builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1464690187.38 results: success (0) buildid: 20160531004027 builduid: b6dc0f9f274946b485520dfb64c9b018 revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.379197) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.383726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.384075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.472984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.473381) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 03:23:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.2M=0s 2016-05-31 03:23:07 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.600136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.600452) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:07.650274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-31 03:23:07.653758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 03:23:07,777 truncating revision to first 12 chars 2016-05-31 03:23:07,777 Setting DEBUG logging. 2016-05-31 03:23:07,778 attempt 1/10 2016-05-31 03:23:07,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3c7a33fe0b64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 03:23:09,464 unpacking tar archive at: mozilla-aurora-3c7a33fe0b64/testing/mozharness/ program finished with exit code 0 elapsedTime=2.065438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-31 03:23:09.732852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:09.733238) ========= script_repo_revision: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:09.733742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:09.734078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 03:23:09.744141) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-31 03:23:09.744635) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:09 INFO - MultiFileLogger online at 20160531 03:23:09 in /builds/slave/test 03:23:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:23:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:09 INFO - {'append_to_log': False, 03:23:09 INFO - 'base_work_dir': '/builds/slave/test', 03:23:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:23:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:09 INFO - 'branch': 'Mozilla-Aurora', 03:23:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:09 INFO - 'config_files': ('talos/linux_config.py',), 03:23:09 INFO - 'default_actions': ('clobber', 03:23:09 INFO - 'read-buildbot-config', 03:23:09 INFO - 'download-and-extract', 03:23:09 INFO - 'populate-webroot', 03:23:09 INFO - 'create-virtualenv', 03:23:09 INFO - 'install', 03:23:09 INFO - 'run-tests'), 03:23:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:09 INFO - 'download_minidump_stackwalk': True, 03:23:09 INFO - 'download_symbols': 'ondemand', 03:23:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:09 INFO - 'installer_path': 'installer.exe', 03:23:09 INFO - 'log_level': 'info', 03:23:09 INFO - 'log_name': 'talos', 03:23:09 INFO - 'log_to_console': True, 03:23:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:09 INFO - 'opt_config_files': (), 03:23:09 INFO - 'pip_index': False, 03:23:09 INFO - 'sps_profile': False, 03:23:09 INFO - 'sps_profile_interval': 0, 03:23:09 INFO - 'suite': 'dromaeojs', 03:23:09 INFO - 'system_bits': '32', 03:23:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:09 INFO - 'title': 'talos-linux64-ix-038', 03:23:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:09 INFO - 'use_talos_json': True, 03:23:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:09 INFO - 'work_dir': 'build'} 03:23:09 INFO - ##### 03:23:09 INFO - ##### Running clobber step. 03:23:09 INFO - ##### 03:23:09 INFO - Running pre-action listener: _resource_record_pre_action 03:23:09 INFO - Running main action method: clobber 03:23:09 INFO - rmtree: /builds/slave/test/build 03:23:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:10 INFO - Running post-action listener: _resource_record_post_action 03:23:10 INFO - ##### 03:23:10 INFO - ##### Running read-buildbot-config step. 03:23:10 INFO - ##### 03:23:10 INFO - Running pre-action listener: _resource_record_pre_action 03:23:10 INFO - Running main action method: read_buildbot_config 03:23:10 INFO - Using buildbot properties: 03:23:10 INFO - { 03:23:10 INFO - "project": "", 03:23:10 INFO - "product": "firefox", 03:23:10 INFO - "script_repo_revision": "production", 03:23:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:23:10 INFO - "repository": "", 03:23:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:23:10 INFO - "buildid": "20160531004027", 03:23:10 INFO - "stage_platform": "linux64-pgo", 03:23:10 INFO - "basedir": "/builds/slave/test", 03:23:10 INFO - "nightly_build": "True", 03:23:10 INFO - "buildnumber": 277, 03:23:10 INFO - "slavename": "talos-linux64-ix-038", 03:23:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:23:10 INFO - "platform": "ubuntu64_hw", 03:23:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:23:10 INFO - "branch": "mozilla-aurora", 03:23:10 INFO - "repo_path": "releases/mozilla-aurora", 03:23:10 INFO - "revision": "3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4", 03:23:10 INFO - "pgo_build": "True", 03:23:10 INFO - "builduid": "b6dc0f9f274946b485520dfb64c9b018", 03:23:10 INFO - "slavebuilddir": "test" 03:23:10 INFO - } 03:23:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:23:10 INFO - Running post-action listener: _resource_record_post_action 03:23:10 INFO - ##### 03:23:10 INFO - ##### Running download-and-extract step. 03:23:10 INFO - ##### 03:23:10 INFO - Running pre-action listener: _resource_record_pre_action 03:23:10 INFO - Running main action method: download_and_extract 03:23:10 INFO - mkdir: /builds/slave/test/build/tests 03:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:10 INFO - https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:23:12 INFO - Downloaded 1361 bytes. 03:23:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:23:12 INFO - Using the following test package requirements: 03:23:12 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:12 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:23:12 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:23:12 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'jsshell-linux-x86_64.zip'], 03:23:12 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:23:12 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:23:12 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:23:12 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:23:12 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:23:12 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:23:12 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:23:12 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:12 INFO - https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:14 INFO - Downloaded 24174819 bytes. 03:23:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:16 INFO - Return code: 0 03:23:16 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:16 INFO - https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:23:18 INFO - Downloaded 24174819 bytes. 03:23:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:23:19 INFO - Return code: 0 03:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:19 INFO - https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:23:21 INFO - Downloaded 10840145 bytes. 03:23:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:23:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:23:21 INFO - Return code: 0 03:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:21 INFO - https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:23:25 INFO - Downloaded 62769507 bytes. 03:23:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:23:25 INFO - mkdir: /builds/slave/test/properties 03:23:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:25 INFO - Contents: 03:23:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:23:25 INFO - Running post-action listener: _resource_record_post_action 03:23:25 INFO - Running post-action listener: set_extra_try_arguments 03:23:25 INFO - ##### 03:23:25 INFO - ##### Running populate-webroot step. 03:23:25 INFO - ##### 03:23:25 INFO - Running pre-action listener: _resource_record_pre_action 03:23:25 INFO - Running main action method: populate_webroot 03:23:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:26 INFO - '--tppagecycles', 03:23:26 INFO - '7'], 03:23:26 INFO - 'tests': ['tsvgm']}}, 03:23:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['damp', 'tps']}, 03:23:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'tests': ['damp', 'tps']}, 03:23:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['dromaeo_dom']}, 03:23:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['a11yr', 03:23:26 INFO - 'ts_paint', 03:23:26 INFO - 'tpaint', 03:23:26 INFO - 'sessionrestore', 03:23:26 INFO - 'sessionrestore_no_auto_restore', 03:23:26 INFO - 'tabpaint']}, 03:23:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['tsvgx', 03:23:26 INFO - 'tsvgr_opacity', 03:23:26 INFO - 'tart', 03:23:26 INFO - 'tscrollx', 03:23:26 INFO - 'cart']}, 03:23:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:26 INFO - 'tsvgr_opacity', 03:23:26 INFO - 'tart', 03:23:26 INFO - 'tscrollx', 03:23:26 INFO - 'cart']}, 03:23:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'talos_options': ['--disable-e10s'], 03:23:26 INFO - 'tests': ['tp5o']}, 03:23:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'tests': ['tp5o']}, 03:23:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'talos_options': ['--disable-e10s', 03:23:26 INFO - '--xperf_path', 03:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:26 INFO - 'tests': ['tp5n']}, 03:23:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:26 INFO - 'talos_options': ['--xperf_path', 03:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:26 INFO - 'tests': ['tp5n']}}, 03:23:26 INFO - 'talos.zip': {'path': '', 03:23:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:26 INFO - Running post-action listener: _resource_record_post_action 03:23:26 INFO - ##### 03:23:26 INFO - ##### Running create-virtualenv step. 03:23:26 INFO - ##### 03:23:26 INFO - Running pre-action listener: _resource_record_pre_action 03:23:26 INFO - Running main action method: create_virtualenv 03:23:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:26 INFO - Using real prefix '/usr' 03:23:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:28 INFO - Installing pip.................done. 03:23:28 INFO - Return code: 0 03:23:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:28 INFO - Using env: {'DISPLAY': ':0', 03:23:28 INFO - 'HOME': '/home/cltbld', 03:23:28 INFO - 'LANG': 'en_US.UTF-8', 03:23:28 INFO - 'LANGUAGE': 'en_US:en', 03:23:28 INFO - 'LOGNAME': 'cltbld', 03:23:28 INFO - 'MAIL': '/var/mail/cltbld', 03:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:28 INFO - 'MOZ_NO_REMOTE': '1', 03:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:28 INFO - 'NO_EM_RESTART': '1', 03:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:28 INFO - 'PWD': '/builds/slave/test', 03:23:28 INFO - 'SHELL': '/bin/bash', 03:23:28 INFO - 'SHLVL': '1', 03:23:28 INFO - 'TERM': 'linux', 03:23:28 INFO - 'TMOUT': '86400', 03:23:28 INFO - 'USER': 'cltbld', 03:23:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:28 INFO - '_': '/tools/buildbot/bin/python'} 03:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:23:28 INFO - Cleaning up... 03:23:28 INFO - Return code: 0 03:23:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:23:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:23:28 INFO - Using env: {'DISPLAY': ':0', 03:23:28 INFO - 'HOME': '/home/cltbld', 03:23:28 INFO - 'LANG': 'en_US.UTF-8', 03:23:28 INFO - 'LANGUAGE': 'en_US:en', 03:23:28 INFO - 'LOGNAME': 'cltbld', 03:23:28 INFO - 'MAIL': '/var/mail/cltbld', 03:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:28 INFO - 'MOZ_NO_REMOTE': '1', 03:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:28 INFO - 'NO_EM_RESTART': '1', 03:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:28 INFO - 'PWD': '/builds/slave/test', 03:23:28 INFO - 'SHELL': '/bin/bash', 03:23:28 INFO - 'SHLVL': '1', 03:23:28 INFO - 'TERM': 'linux', 03:23:28 INFO - 'TMOUT': '86400', 03:23:28 INFO - 'USER': 'cltbld', 03:23:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:28 INFO - '_': '/tools/buildbot/bin/python'} 03:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:28 INFO - Downloading/unpacking psutil>=0.7.1 03:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:30 INFO - Installing collected packages: psutil 03:23:30 INFO - Running setup.py install for psutil 03:23:31 INFO - building 'psutil._psutil_linux' extension 03:23:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:23:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:23:31 INFO - building 'psutil._psutil_posix' extension 03:23:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:23:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:31 INFO - Successfully installed psutil 03:23:31 INFO - Cleaning up... 03:23:31 INFO - Return code: 0 03:23:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:23:31 INFO - Using env: {'DISPLAY': ':0', 03:23:31 INFO - 'HOME': '/home/cltbld', 03:23:31 INFO - 'LANG': 'en_US.UTF-8', 03:23:31 INFO - 'LANGUAGE': 'en_US:en', 03:23:31 INFO - 'LOGNAME': 'cltbld', 03:23:31 INFO - 'MAIL': '/var/mail/cltbld', 03:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:31 INFO - 'MOZ_NO_REMOTE': '1', 03:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:31 INFO - 'NO_EM_RESTART': '1', 03:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:31 INFO - 'PWD': '/builds/slave/test', 03:23:31 INFO - 'SHELL': '/bin/bash', 03:23:31 INFO - 'SHLVL': '1', 03:23:31 INFO - 'TERM': 'linux', 03:23:31 INFO - 'TMOUT': '86400', 03:23:31 INFO - 'USER': 'cltbld', 03:23:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:31 INFO - '_': '/tools/buildbot/bin/python'} 03:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:23:33 INFO - Installing collected packages: mozsystemmonitor 03:23:33 INFO - Running setup.py install for mozsystemmonitor 03:23:33 INFO - Successfully installed mozsystemmonitor 03:23:33 INFO - Cleaning up... 03:23:33 INFO - Return code: 0 03:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:33 INFO - Using env: {'DISPLAY': ':0', 03:23:33 INFO - 'HOME': '/home/cltbld', 03:23:33 INFO - 'LANG': 'en_US.UTF-8', 03:23:33 INFO - 'LANGUAGE': 'en_US:en', 03:23:33 INFO - 'LOGNAME': 'cltbld', 03:23:33 INFO - 'MAIL': '/var/mail/cltbld', 03:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:33 INFO - 'MOZ_NO_REMOTE': '1', 03:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:33 INFO - 'NO_EM_RESTART': '1', 03:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:33 INFO - 'PWD': '/builds/slave/test', 03:23:33 INFO - 'SHELL': '/bin/bash', 03:23:33 INFO - 'SHLVL': '1', 03:23:33 INFO - 'TERM': 'linux', 03:23:33 INFO - 'TMOUT': '86400', 03:23:33 INFO - 'USER': 'cltbld', 03:23:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:33 INFO - '_': '/tools/buildbot/bin/python'} 03:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:36 INFO - Downloading docopt-0.6.1.tar.gz 03:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:36 INFO - Running setup.py install for blobuploader 03:23:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:36 INFO - Running setup.py install for requests 03:23:37 INFO - Running setup.py install for docopt 03:23:37 INFO - Successfully installed blobuploader requests docopt 03:23:37 INFO - Cleaning up... 03:23:37 INFO - Return code: 0 03:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:37 INFO - Using env: {'DISPLAY': ':0', 03:23:37 INFO - 'HOME': '/home/cltbld', 03:23:37 INFO - 'LANG': 'en_US.UTF-8', 03:23:37 INFO - 'LANGUAGE': 'en_US:en', 03:23:37 INFO - 'LOGNAME': 'cltbld', 03:23:37 INFO - 'MAIL': '/var/mail/cltbld', 03:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:37 INFO - 'MOZ_NO_REMOTE': '1', 03:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:37 INFO - 'NO_EM_RESTART': '1', 03:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:37 INFO - 'PWD': '/builds/slave/test', 03:23:37 INFO - 'SHELL': '/bin/bash', 03:23:37 INFO - 'SHLVL': '1', 03:23:37 INFO - 'TERM': 'linux', 03:23:37 INFO - 'TMOUT': '86400', 03:23:37 INFO - 'USER': 'cltbld', 03:23:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:37 INFO - '_': '/tools/buildbot/bin/python'} 03:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:37 INFO - Running setup.py (path:/tmp/pip-4Z4rtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:37 INFO - Running setup.py (path:/tmp/pip-KK_l4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:37 INFO - Running setup.py (path:/tmp/pip-YMxCGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:37 INFO - Running setup.py (path:/tmp/pip-Q7S8lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:37 INFO - Running setup.py (path:/tmp/pip-HPb9tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:37 INFO - Running setup.py (path:/tmp/pip-jMABmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:37 INFO - Running setup.py (path:/tmp/pip-8OwsLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:38 INFO - Running setup.py (path:/tmp/pip-vjBIv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:38 INFO - Running setup.py (path:/tmp/pip-LrywGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:38 INFO - Running setup.py (path:/tmp/pip-ncXub_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:38 INFO - Running setup.py (path:/tmp/pip-3QMZg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:38 INFO - Running setup.py (path:/tmp/pip-IZJwol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:38 INFO - Running setup.py (path:/tmp/pip-JX0rSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:38 INFO - Running setup.py (path:/tmp/pip-lSgt7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:38 INFO - Running setup.py (path:/tmp/pip-Er0948-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:38 INFO - Running setup.py (path:/tmp/pip-4HeIOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:38 INFO - Running setup.py (path:/tmp/pip-DjOkKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:38 INFO - Running setup.py install for manifestparser 03:23:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:38 INFO - Running setup.py install for mozcrash 03:23:38 INFO - Running setup.py install for mozdebug 03:23:39 INFO - Running setup.py install for mozdevice 03:23:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for mozfile 03:23:39 INFO - Running setup.py install for mozhttpd 03:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for mozinfo 03:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for mozInstall 03:23:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for mozleak 03:23:39 INFO - Running setup.py install for mozlog 03:23:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for moznetwork 03:23:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:39 INFO - Running setup.py install for mozprocess 03:23:39 INFO - Running setup.py install for mozprofile 03:23:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Running setup.py install for mozrunner 03:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Running setup.py install for mozscreenshot 03:23:40 INFO - Running setup.py install for moztest 03:23:40 INFO - Running setup.py install for mozversion 03:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:40 INFO - Cleaning up... 03:23:40 INFO - Return code: 0 03:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:40 INFO - Using env: {'DISPLAY': ':0', 03:23:40 INFO - 'HOME': '/home/cltbld', 03:23:40 INFO - 'LANG': 'en_US.UTF-8', 03:23:40 INFO - 'LANGUAGE': 'en_US:en', 03:23:40 INFO - 'LOGNAME': 'cltbld', 03:23:40 INFO - 'MAIL': '/var/mail/cltbld', 03:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:40 INFO - 'MOZ_NO_REMOTE': '1', 03:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:40 INFO - 'NO_EM_RESTART': '1', 03:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:40 INFO - 'PWD': '/builds/slave/test', 03:23:40 INFO - 'SHELL': '/bin/bash', 03:23:40 INFO - 'SHLVL': '1', 03:23:40 INFO - 'TERM': 'linux', 03:23:40 INFO - 'TMOUT': '86400', 03:23:40 INFO - 'USER': 'cltbld', 03:23:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:40 INFO - '_': '/tools/buildbot/bin/python'} 03:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:40 INFO - Running setup.py (path:/tmp/pip-Lz5hPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:40 INFO - Running setup.py (path:/tmp/pip-dTwHOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:40 INFO - Running setup.py (path:/tmp/pip-Z6lmT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:40 INFO - Running setup.py (path:/tmp/pip-15Ceqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:41 INFO - Running setup.py (path:/tmp/pip-tOIy2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:41 INFO - Running setup.py (path:/tmp/pip-6cenXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:41 INFO - Running setup.py (path:/tmp/pip-GDLCWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:41 INFO - Running setup.py (path:/tmp/pip-VDLwCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:41 INFO - Running setup.py (path:/tmp/pip-2Sv47A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:41 INFO - Running setup.py (path:/tmp/pip-qDjO1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:41 INFO - Running setup.py (path:/tmp/pip-iHpIyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:41 INFO - Running setup.py (path:/tmp/pip-ca0CtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:41 INFO - Running setup.py (path:/tmp/pip-6p1z8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:41 INFO - Running setup.py (path:/tmp/pip-ul5lUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:41 INFO - Running setup.py (path:/tmp/pip-WTEJZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:41 INFO - Running setup.py (path:/tmp/pip-nC_iAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:41 INFO - Running setup.py (path:/tmp/pip-oQqorG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:23:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:43 INFO - Downloading blessings-1.6.tar.gz 03:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:43 INFO - Installing collected packages: blessings 03:23:43 INFO - Running setup.py install for blessings 03:23:44 INFO - Successfully installed blessings 03:23:44 INFO - Cleaning up... 03:23:44 INFO - Return code: 0 03:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:44 INFO - Reading from file tmpfile_stdout 03:23:44 INFO - Current package versions: 03:23:44 INFO - argparse == 1.2.1 03:23:44 INFO - blessings == 1.6 03:23:44 INFO - blobuploader == 1.2.4 03:23:44 INFO - docopt == 0.6.1 03:23:44 INFO - manifestparser == 1.1 03:23:44 INFO - mozInstall == 1.12 03:23:44 INFO - mozcrash == 0.17 03:23:44 INFO - mozdebug == 0.1 03:23:44 INFO - mozdevice == 0.48 03:23:44 INFO - mozfile == 1.2 03:23:44 INFO - mozhttpd == 0.7 03:23:44 INFO - mozinfo == 0.9 03:23:44 INFO - mozleak == 0.1 03:23:44 INFO - mozlog == 3.1 03:23:44 INFO - moznetwork == 0.27 03:23:44 INFO - mozprocess == 0.22 03:23:44 INFO - mozprofile == 0.28 03:23:44 INFO - mozrunner == 6.11 03:23:44 INFO - mozscreenshot == 0.1 03:23:44 INFO - mozsystemmonitor == 0.0 03:23:44 INFO - moztest == 0.7 03:23:44 INFO - mozversion == 1.4 03:23:44 INFO - psutil == 3.1.1 03:23:44 INFO - requests == 1.2.3 03:23:44 INFO - wsgiref == 0.1.2 03:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:23:44 INFO - Using env: {'DISPLAY': ':0', 03:23:44 INFO - 'HOME': '/home/cltbld', 03:23:44 INFO - 'LANG': 'en_US.UTF-8', 03:23:44 INFO - 'LANGUAGE': 'en_US:en', 03:23:44 INFO - 'LOGNAME': 'cltbld', 03:23:44 INFO - 'MAIL': '/var/mail/cltbld', 03:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:44 INFO - 'MOZ_NO_REMOTE': '1', 03:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:44 INFO - 'NO_EM_RESTART': '1', 03:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:44 INFO - 'PWD': '/builds/slave/test', 03:23:44 INFO - 'SHELL': '/bin/bash', 03:23:44 INFO - 'SHLVL': '1', 03:23:44 INFO - 'TERM': 'linux', 03:23:44 INFO - 'TMOUT': '86400', 03:23:44 INFO - 'USER': 'cltbld', 03:23:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:44 INFO - '_': '/tools/buildbot/bin/python'} 03:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:23:44 INFO - Cleaning up... 03:23:44 INFO - Return code: 0 03:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:44 INFO - Using env: {'DISPLAY': ':0', 03:23:44 INFO - 'HOME': '/home/cltbld', 03:23:44 INFO - 'LANG': 'en_US.UTF-8', 03:23:44 INFO - 'LANGUAGE': 'en_US:en', 03:23:44 INFO - 'LOGNAME': 'cltbld', 03:23:44 INFO - 'MAIL': '/var/mail/cltbld', 03:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:44 INFO - 'MOZ_NO_REMOTE': '1', 03:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:44 INFO - 'NO_EM_RESTART': '1', 03:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:44 INFO - 'PWD': '/builds/slave/test', 03:23:44 INFO - 'SHELL': '/bin/bash', 03:23:44 INFO - 'SHLVL': '1', 03:23:44 INFO - 'TERM': 'linux', 03:23:44 INFO - 'TMOUT': '86400', 03:23:44 INFO - 'USER': 'cltbld', 03:23:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:44 INFO - '_': '/tools/buildbot/bin/python'} 03:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:44 INFO - Downloading/unpacking jsonschema 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:46 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:46 INFO - warning: no files found matching '*.txt' 03:23:46 INFO - no previously-included directories found matching 'build' 03:23:46 INFO - no previously-included directories found matching 'dist' 03:23:46 INFO - no previously-included directories found matching '.git*' 03:23:46 INFO - Installing collected packages: jsonschema, functools32 03:23:47 INFO - Running setup.py install for functools32 03:23:47 INFO - warning: no files found matching '*.txt' 03:23:47 INFO - no previously-included directories found matching 'build' 03:23:47 INFO - no previously-included directories found matching 'dist' 03:23:47 INFO - no previously-included directories found matching '.git*' 03:23:47 INFO - Successfully installed jsonschema functools32 03:23:47 INFO - Cleaning up... 03:23:47 INFO - Return code: 0 03:23:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ec44f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14925a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:23:47 INFO - Using env: {'DISPLAY': ':0', 03:23:47 INFO - 'HOME': '/home/cltbld', 03:23:47 INFO - 'LANG': 'en_US.UTF-8', 03:23:47 INFO - 'LANGUAGE': 'en_US:en', 03:23:47 INFO - 'LOGNAME': 'cltbld', 03:23:47 INFO - 'MAIL': '/var/mail/cltbld', 03:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:47 INFO - 'MOZ_NO_REMOTE': '1', 03:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:47 INFO - 'NO_EM_RESTART': '1', 03:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:47 INFO - 'PWD': '/builds/slave/test', 03:23:47 INFO - 'SHELL': '/bin/bash', 03:23:47 INFO - 'SHLVL': '1', 03:23:47 INFO - 'TERM': 'linux', 03:23:47 INFO - 'TMOUT': '86400', 03:23:47 INFO - 'USER': 'cltbld', 03:23:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:47 INFO - '_': '/tools/buildbot/bin/python'} 03:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:47 INFO - Downloading/unpacking flake8 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:49 INFO - no previously-included directories found matching 'docs/_build' 03:23:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:50 INFO - Running setup.py install for pep8 03:23:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:50 INFO - no previously-included directories found matching 'docs/_build' 03:23:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:23:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:50 INFO - Cleaning up... 03:23:50 INFO - Return code: 0 03:23:50 INFO - Running post-action listener: _resource_record_post_action 03:23:50 INFO - Running post-action listener: _start_resource_monitoring 03:23:50 INFO - Starting resource monitoring. 03:23:50 INFO - ##### 03:23:50 INFO - ##### Running install step. 03:23:50 INFO - ##### 03:23:50 INFO - Running pre-action listener: _resource_record_pre_action 03:23:50 INFO - Running main action method: install 03:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:50 INFO - Reading from file tmpfile_stdout 03:23:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:50 INFO - Reading from file tmpfile_stdout 03:23:50 INFO - Output received: 03:23:50 INFO - Usage: mozinstall [options] installer 03:23:50 INFO - Options: 03:23:50 INFO - -h, --help show this help message and exit 03:23:50 INFO - -d DEST, --destination=DEST 03:23:50 INFO - Directory to install application into. [default: 03:23:50 INFO - "/builds/slave/test"] 03:23:50 INFO - --app=APP Application being installed. [default: firefox] 03:23:50 INFO - mkdir: /builds/slave/test/build/application 03:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:24:08 INFO - Reading from file tmpfile_stdout 03:24:08 INFO - Output received: 03:24:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:08 INFO - Running post-action listener: _resource_record_post_action 03:24:08 INFO - ##### 03:24:08 INFO - ##### Running run-tests step. 03:24:08 INFO - ##### 03:24:08 INFO - Running pre-action listener: _resource_record_pre_action 03:24:08 INFO - Running main action method: run_tests 03:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:08 INFO - Python 2.7.3 03:24:08 INFO - Return code: 0 03:24:08 INFO - grabbing minidump binary from tooltool 03:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1522310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15227a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:08 INFO - Return code: 0 03:24:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:24:09 INFO - Return code: 0 03:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:24:09 INFO - Using env: {'DISPLAY': ':0', 03:24:09 INFO - 'HOME': '/home/cltbld', 03:24:09 INFO - 'LANG': 'en_US.UTF-8', 03:24:09 INFO - 'LANGUAGE': 'en_US:en', 03:24:09 INFO - 'LOGNAME': 'cltbld', 03:24:09 INFO - 'MAIL': '/var/mail/cltbld', 03:24:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:09 INFO - 'MOZ_NO_REMOTE': '1', 03:24:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:09 INFO - 'NO_EM_RESTART': '1', 03:24:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:09 INFO - 'PWD': '/builds/slave/test', 03:24:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:09 INFO - 'SHELL': '/bin/bash', 03:24:09 INFO - 'SHLVL': '1', 03:24:09 INFO - 'TERM': 'linux', 03:24:09 INFO - 'TMOUT': '86400', 03:24:09 INFO - 'USER': 'cltbld', 03:24:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295', 03:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:09 INFO - '_': '/tools/buildbot/bin/python'} 03:24:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:24:09 INFO - mozversion application_buildid: 20160531004027 03:24:09 INFO - mozversion application_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 03:24:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:24:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:09 INFO - mozversion application_name: Firefox 03:24:09 INFO - mozversion application_remotingname: firefox-dev 03:24:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:09 INFO - mozversion application_vendor: Mozilla 03:24:09 INFO - mozversion application_version: 48.0a2 03:24:09 INFO - mozversion platform_buildid: 20160531004027 03:24:09 INFO - mozversion platform_changeset: 3c7a33fe0b6472bf47264c2390c5bc19f1a6dce4 03:24:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:09 INFO - mozversion platform_version: 48.0a2 03:24:09 INFO - using testdate: 1464690249 03:24:09 INFO - actual date: 1464690249 03:24:09 INFO - starting webserver on 'localhost:51670' 03:24:09 INFO - SUITE-START | Running 2 tests 03:24:09 INFO - TEST-START | dromaeo_css 03:24:09 INFO - operating with platform_type : linux_ 03:24:09 INFO - Initialising browser for dromaeo_css test... 03:24:09 INFO - TEST-INFO | started process 13267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZp5_vj/profile http://localhost:51670/getInfo.html) 03:24:14 INFO - PROCESS | 13267 | __metrics Screen width/height:1600/1200 03:24:14 INFO - PROCESS | 13267 | colorDepth:24 03:24:14 INFO - PROCESS | 13267 | Browser inner width/height: 1024/697 03:24:14 INFO - PROCESS | 13267 | __metrics 03:24:16 ERROR - PROCESS | 13267 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:24:16 INFO - TEST-INFO | 13267: exit 0 03:24:16 INFO - Browser initialized. 03:24:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:16 INFO - TEST-INFO | started process 13359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZp5_vj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:28 INFO - PROCESS | 13359 | RSS: Main: 142270464 03:24:28 INFO - PROCESS | 13359 | 03:25:19 INFO - PROCESS | 13359 | 1464690319849 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:27:27 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51670/tests/dromaeo/cssquery-ext.html) 03:27:28 INFO - PROCESS | 13359 | RSS: Main: 245264384 03:27:28 INFO - PROCESS | 13359 | 03:30:31 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-ext.html (next: http://localhost:51670/tests/dromaeo/cssquery-jquery.html) 03:30:31 INFO - PROCESS | 13359 | RSS: Main: 223059968 03:30:31 INFO - PROCESS | 13359 | 03:33:33 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51670/tests/dromaeo/cssquery-mootools.html) 03:33:34 INFO - PROCESS | 13359 | RSS: Main: 220004352 03:33:34 INFO - PROCESS | 13359 | 03:36:35 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51670/tests/dromaeo/cssquery-prototype.html) 03:36:36 INFO - PROCESS | 13359 | RSS: Main: 217079808 03:36:36 INFO - PROCESS | 13359 | 03:39:39 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51670/tests/dromaeo/cssquery-yui.html) 03:39:39 INFO - PROCESS | 13359 | RSS: Main: 181166080 03:39:39 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | Cycle 1(1): loaded http://localhost:51670/tests/dromaeo/cssquery-yui.html (next: http://localhost:51670/tests/dromaeo/cssquery-dojo.html) 03:42:42 INFO - PROCESS | 13359 | RSS: Main: 254418944 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | __start_tp_report 03:42:42 INFO - PROCESS | 13359 | _x_x_mozilla_page_load 03:42:42 INFO - PROCESS | 13359 | _x_x_mozilla_page_load_details 03:42:42 INFO - PROCESS | 13359 | |i|pagename|runs| 03:42:42 INFO - PROCESS | 13359 | |0;dojo.html;3334.4831551109573;3376.27410106827;3377.6115746689125;3394.6435624259443;3417.0603084151853;5529;5530.142827861688;5539.446055394458;5544.528715059219;5549.833504994852;5545.306836645419;5556.361018482876;5582.804601838937;5593.888122237553;5661.405552416988;4967.950320496803;4978.178600530908;5145.253938178962;5185.377754669426;5225.8954820903555;4951.950480495203;5020.472850350716;5024.598032157419;5024.773885175157;5035.144025515671;5022.19644856823;5032.4967503249745;5034.446210916796;5060.84817455477;5080.923786143211;5068.923966140511;5088.771005304751;5126.231065340192;5134.409542902539;5161.509656582619;4939.086269040239;4961.652684312099;5031.119554078058;5048.066107770038;5063.291139240509;5384.057789886754;5430.59270554706;5450.182472629098;5457.263269458612;5472.206530053159;5854.297484301911;5855.707214639294;5859.648421094748;5904.498117660004;5904.822855314347;5852.209951656514;5921.970390148064;5937.346891841894;5964.343922168558;5979.581429299951;5493.917591236134;5514.834554963358;5528.7235638218735;5533.280673512418;5539.806106786284;5981.850453738604;6001.879962400728;6011.729472173763;6016.669083200379;6020.909686354708;5800.158976948319;5813.273340832396;5853.560982926298;5858.472737453564;5858.8242352729485;5889.1755154278435;5902.026165682701;5903.0555111182;5904.202932604044;5906.793262235801;5793.478586927196;5822.7088645567555;5832.737526811304;5872.060470324727;5881.411858814085;5845.795397161079;5850.47345738877;5852.444017818386;5877.23595932526;5896.351401345849;4407.493138289074;4407.6914615976575;4408.448943882015;4411;4434;3897.707671924617;3929.155231625214;3943.7042221833476;3977.880663580097;4003.539592946848;5649.971750141223;5661.943380566142;5669.943300566942;5675.772969081273;5681.772729090872;5942.58401911862;5956;5957.791477298274;5957.79147729836;5958.523318134538;5550.47270509301;5576.079946808813;5626.212330273765;5651.463111004448;5683.0338842396895;5083.669561478492;5087.87280317995;5090.745462726849;5112.4120726116225;5114.33513643224;6163.476104531075;6166;6168.599041062316;6169.938300616936;6170.845728856725;5895.115732640138;5908.852278693067;5916.911246331395;5975.611585246945;6089.451949324582;6178.69106544662;6195.1636529068;6196.504279657526;6200.906986395298;6202.441780239619;5750.338711048115;5754.683492407958;5756.222909907109;5764.106563482667;5824;5851.912221316598;5852.5317974561085;5921.585489015728;5928.644281343133;5935.940640593712;5671.206031155559;5732.942670573241;5742.712864356682;5744.3394009687745;5750.827475175752;5686.9715651421475;5740.483356497935;5740.598158129058;5740.856478588069;5743.368229494668;5628;5631.127175287673;5693.629914055573;5723;5734.3978882218435;5742.799002034909;5760.337561180518;5775.48020678141;5775.7400916957995;5783.306003279465;5600.047991841316;5643.492085712305;5646.88706225865;5651.745671444877;5702.942970570241 03:42:42 INFO - PROCESS | 13359 | |1;ext.html;670.6546128743698;683.0914883205337;684.4079870911661;726.9023774101106;741.9925800741994;32299.354012919757;32838;39381.99999999996;39853.20293594126;39925.60074399255;43261;43700.3444948326;43790.34314485277;43802.78098609502;43914.78042609782;7954.562499062549;8795.560221988906;8956.507392093432;8974.05772393899;10232.846507302396;10242.641507547238;10363.948180259089;10366.844497332546;10372.636957706482;10379.896201038006;10363.119134873545;10401.583936642524;10415.16678665705;10432.374057556572;10432.478376081204;10299.63951261706;10336.844947325833;10347.482625868752;10360.533775980099;10369.585216591327;10243.84634230487;10262.230332725076;10369.377837329785;10710.03609675133;10730.892691073068;43223.78388108071;43300.13399731988;43582.564174358486;43749.562504374866;43765.12469750619;3954.268460334847;3990.541087774914;4013.999999999971;4095.28332541804;4139.710220284582;33220;33400.16499587506;33436.83281583601;33491.33017339664;33640;4338.3058710606465;4408.316710909814;4413.602775750198;4453.621442177418;4467.620252278561;324556;326282;329452;331387;331883.34058329795;40999.38500922488;61788.69105654533;62613.37386626167;62685.37314626887;62714;39638;39685.80157099254;39809;39869.800650996556;39877;17118.914405427895;17332;17379;17386.826131738522;17396.47810565685;13471.393787279596;14647.194404307866;14875.404983800527;14908.70182596342;14925.477608283658;9061.456312621263;9078.54607269634;9088.909110908806;9139.862902056475;9183.081691830897;3444.4488881778793;3563.2695297463956;3567.8929632111076;3575.0526110580195;3589.964100359015;1127.0082327551702;1128.8870420389107;1146.7247860513417;1229.8339724137127;1235.9876401236052;33435.331293373994;34271.828640856635;36531.452028219595;37508.43737343942;38059.809700951315;1217.1358335581835;1226.6320103968774;1240.0203838967295;1259.0934527140444;1290.3806173036994;16488.658831009972;16927.322907083824;16957.321707131825;17102.401415950382;17219.56951076208;500270;505578;505726;506033;506044;60800;61382;61467.07799383013;61478.38521614816;61512;1399.4961813747043;1488.6501672107047;1552.6196081959993;1560.1263292556205;1560.2432820082252;29302;30018.3996320068;32334.676653234106;33208.33583328368;33632.83183584066;50795.492045079074;51324.23013654724;51449.48550514447;51457.48542514527;51483.74258128685;372352;379129;379141;380390;512972;29813.403731925675;30015.249618759706;30285.394292114474;30594.84702576562;30634.693653063183;47398.76300618613;47764.28353574769;48293.309734159135;48526.5147348522;48776.75611622061;40654.79672601618;40751;40772.79613601913;41008.38487422751;41028.38457423081;37982;38974.4153837687;39970.40044399278;40386.39420408638;40504;40632;41641.375379369936;41712.3743143847;42109.368359475244;42609.78695106505;34818.30363392769;35557.82221088981;36402.635973639924;36644.45033324556;36881.81559092188;27914.44171116607;28133.859330703217;28309.858450708438;28511.857440712665;28550 03:42:42 INFO - PROCESS | 13359 | |2;jquery.html;406.74578388507183;414.88383252689243;416.843683618643;422.0061754567992;423.4727763933903;13612.976821019656;18421.907890460545;18948.810511894895;19013.33453329132;20511;15621.92189039056;18282.360117395892;18766;19119.71320430195;19245.903770481164;5589.664620122785;5757.193992841006;5760.193572899777;5780.450857168583;5780.537556995451;5650.51970582501;5716;5749.166370876221;5761.30864296285;5762.654240745548;4185.183889141618;6031.366706495821;6281.905771413432;6291.276503202122;6295.527835412339;6178.10417489466;6214.844628884269;6221.937780622181;6229.626222426669;6230.626162430269;5526.944730552724;5732.5127364174095;5736.827895163152;5750.913736293959;5764.596478246524;22863.657045144337;22994.310170694906;23419.648705269436;23701.762982370128;23775.16786912467;2573.61395790631;2642.2469596165;2670.5326567850548;2691.5155272051024;3105.6894310568987;14430.134191948517;14755;15085.39658413662;15359.692806143814;15488.380464781396;1990.8307793837396;2046.2019812273224;2126.0857831132607;2134.466383404149;2198.2525941179915;84010;89594;91476.54261728715;91800.54099729525;93068.99999999932;11452.484638191134;11519.19365644397;11547;11622.70943226426;11732.178747487595;16223.432179873647;16314.184290785413;16490.093044882407;16492.67014659724;16507.422240221775;8433.578321083922;8616.48301101936;8662.350323725746;8696.608652610648;8715.912840871637;8361.749147525585;8371.58142092893;8377.287930525852;8428.157184281645;8446.408751387344;4601.3558101865765;4749.192637251606;5015.924761128586;5059.266406371055;5089.618278629117;2044.2231951858496;2073.5438203595186;2082.8031516494275;2093.120889226498;2118.6504226802713;1004.1765752083368;1045.46158728255;1070.8179609466254;1150.810116330813;1156.115571587736;17926.462206133838;17931.282748690166;18550.72173917392;19088.80911190898;19216.807831921782;1059.9470026498643;1102.8566286382718;1118.9608363707232;1143.988560114405;1147.6958605969426;10204.38773673567;10931.836022459669;11050.944745276383;11077.944610277058;11151.665450036511;355995;356693;357066;494985;509739;77018.08777789392;77247;88030;92531.5373423142;93586;1101.54285971321;1109.5395410904546;1121.1311233793874;1132.1621999720148;1153.140910022039;17117;17268.309267629153;17389.956757567626;17415.651686965935;17445.389411370543;40313.79843100766;41559.58440415678;42053.1589368217;43577.12845743004;43764.56235437605;61047;61143.38856611555;61414.38585614265;61460.385396145466;61523;8784;8894.866577001221;9028.503432311287;9210.171084602418;9256.676016339396;9424.764380890532;12530.37348132608;12769.744605108031;13140.60578182656;13336.599902002956;11661.6501504955;11725.061995040205;11898.821517677416;12078.51685932553;12250.387480626112;11970.772296612118;12067.57763478274;12135.939320303341;12143;12188.57339993096;12482.251064936132;12543.749125017632;12580.937095314464;12622.684432889251;12760.74478510406;8623.65505379803;8901.910980890108;8915.197632213132;8993.955030224806;9000.324975626985;11891.405429728651;12282.140250182401;12369.690757731129;12443.813342799684;12619.74760504803 03:42:42 INFO - PROCESS | 13359 | |3;mootools.html;1339.129565782241;1569.5919061044126;1607.3249235321168;1819.9727004094932;1931.9130639121238;7454.776356709301;8233;8366.28886544643;8420.157984201593;8437.240648341649;8204.261616454518;8353.791155221123;8370.162983701626;8378.497290162595;8383.329333653308;2133.8826364549946;2172.142003908455;2428.0530593068715;2451.240115564172;2472.9010839566395;2400.927972160838;2415.2150551070886;2419.842710223839;2421.7457166997388;2422.2491027781357;2312.4218945263683;2361.3152185866165;2365.207655435431;2397.280815755275;2405.194259922919;2129.20154941896;2331;2402.987985060081;2443.1815341860497;2452.5953217719057;2354.3172479980785;2358.0921345282018;2376.3346263046374;2378.619420892649;2381.2618088392655;8038.557879316635;8040.2361775631225;8100.554469504175;8110.026796784424;8116.675332986673;5287.814926477555;5353.170258609922;5374.48942350476;5375.139977603565;5380.408155102936;3603.513525674027;3610.711143108545;3737.1591391936595;3757.0419543016355;3758.2859256741403;1180.167981572989;1192.5349113845607;1196.521391443421;1215.8601760797444;1221.45034734369;12140.210886292363;12221.450034748457;12223;12257.080718946025;12274.631761047183;4810.494898035726;4817.325574419584;4823.324734537167;4830.637702172351;4894.8042078317185;10231.641892533875;10241.94879025615;10277.383356998604;10279.074883260393;10286.817016043251;5515.227868098469;5520.641158324696;5531.695756733418;5535.972320138373;5538.6399884007415;4435.911281774346;4888.242322440027;4992.775325110379;5011.072951503984;5015.749212539358;4157.230912281238;4174.937375939363;4176.164767046603;4194.077302993336;4226.2181496422645;1350.6015725361042;1367.43934986655;1373.4506197520873;1381.550995926328;1389.5275606293908;851.7827953871847;941.2940294778916;1051.9368837869752;1063.500154927183;1069.256866477806;6014.729337179838;6087.57386982907;6100.694965251809;6130.63216207029;6135.723892424851;494.053886806761;494.44868971097685;498.06364035612813;506.05367961911463;507.1631807517625;4044.3124668805785;4133.793310334471;4177.310743727251;4222.746635201897;4227.915441691211;10331.94834025825;10686.091682206945;10737.087347575387;10768.0847127995;10780.353178809297;10567.207459440573;10590.841137382946;10607.469626518643;10610.94694526538;10624.946875265729;8191;8265.132161122996;8268.131846156188;8271.1728827118;8274.048484424247;5720.856978575569;5738.454846789548;5743.511801496752;5755.223044888887;5876.118582212703;9397.201237894855;9550.331476796835;9657.806843862943;9687.612495500101;9696.224302055678;8944.821103578022;9228.723138305862;9777.364471309342;9782.559784809842;9803.705888823346;6785.4910881685055;7126.144862616519;7297.890531641923;7403.444741644291;7491.10106787189;8097.2307630774985;8124.106348301801;8127.715529956423;8138.145494723206;8172.468789528662;7001.439884809305;7161.892571611535;7201.13586369618;7274.672639731119;7302.123745150403;7128.786136415916;7221.31397517235;7241.710331586888;7431.182569917197;7594.734184303523;6832.760853370109;6833.2483426824;6865.141857267841;6890.896636550356;6893.138357705287;4870.488598697228;5090.211017292326;5128.7179205144075;5131.615128865275;5137.8201762938115;5322.228276899906;5353.598480113929;5394.514493695587;5417.83746487606;5452.509274165344 03:42:42 INFO - PROCESS | 13359 | |4;prototype.html;335.49005511622335;337.24457215836526;346.4015198243321;351.232556863254;351.75377235934855;6183.690815459226;6211.565190436671;6229.377062293768;6241.063840423933;6254.093156492306;5835.883282334351;6007.789727359544;6087.11736798164;6091.634501929887;6122.326544080159;4680.297955306714;4692.788824502905;4727.9834835510355;4744.881377965561;4758.119747846659;4760.857174284777;4761.738104404257;4769.5707386335225;4771;4779.187538118511;4501.504834468205;4585.403897493338;4708.340832283483;4719.4100737407825;4728.810847566093;4694.201985662411;4699.130660827724;4712.90574188516;4713.316569097462;4718.811247550094;4126.277901367249;4147.232761939051;4150.501939767217;4150.584941505856;4151.750894946313;5982.820515384546;5985.371535988746;5987.850303742398;5991.131285963511;6001.459868611846;5480.972595137038;5492.148716948879;5497.917531236994;5498.395176530578;5506.201600767866;6363.713632886485;6474.125992990933;6497.415232629086;6515.696860627846;6535.738570457176;4597.42532183477;4603.217453032992;4608.608268297199;4610.10103029906;4618.0763847230355;6814.182298124208;6816.909294512904;6824.556403833784;6828.795136145874;6834.350736680008;4702.694324868872;4707.388039554904;4717.103750287434;4718.41019872516;4719.95280047202;4762.214234651313;4774.045190961821;4774.641901857374;4776.379070720854;4777.713337199779;5160.174372100446;5303.787848486095;5486.725663716798;5499.010178167968;5501.614886957875;6502.219733631994;6510.381513756186;6514.902276465857;6561.835954101186;6572.474202063823;1529.9847001529843;1582.1535478518938;1594.1152660273428;1611.7501787223;1617.6036870966689;1036.5231993283173;1044.3942513342242;1045.9633912813167;1049.7847941172042;1052.0741747262514;6273.686315684289;6294.433500984842;6295.433410993032;6364.681765911779;6369.649669268235;6699.464042876558;6706;6707.53047286695;6721.1598550181225;6727.125473688389;6316.968415157895;6325.051242313598;6340.714667839866;6356.237251529754;6365.61806291624;3566.197605538785;3598.370285200132;3602.189507360823;3602.85588576454;3602.9819850901104;6815.829604259933;6919.8962015569805;6963.1296087989;6972.930270697329;6980.581165130108;6720.798376048726;6727;6734.966325168441;6751.594904305757;6756.966215168893;6910.689018994158;6926.376626103674;6928.792136235921;6941.0629565009085;6943.826404339932;6585.967070164618;6596.142501474777;6600.80197594073;6605.834854128685;6608.173978252718;6319.210098737658;6516.609003459807;6522.510811689048;6523.054157147282;6541.836454088496;6914.239433662394;6946.9652651736415;6952.791416257521;6953.965230173817;6968.477364197604;4495.7976891039325;4502.054568540643;4505.932411013903;4507.6619253555455;4507.940633950953;6476.676166191766;6542.901856472062;6590.439812615981;6594.736210551524;6597.175353080865;6416.711247993758;6462.095306657166;6499.317571655098;6525.119108920235;6535.901961470487;6487.124238227779;6498.317676643885;6510.21877374718;6514.3811337922825;6521;6409.583377080475;6436.485081193587;6480.092787009728;6483.222013358239;6497.740090396331;6452.516061295328;6619.569727967667;6624.0395142705;6635.6350400728425;6650.634215118215;6445.806625801233;6470.514711396759;6473.676316184266;6479.254885688018;6485.124508191522 03:42:42 INFO - PROCESS | 13359 | |5;yui.html;816.208277970369;867.488181972636;919.6873063158527;919.9954000229998;937.0254934867738;14877.628059298522;15319.310631021603;15364.154971476564;15368.385264589402;15368.846311536881;14230.857691423083;14261.215633140173;14301.928490357534;14303;14324.498642547487;745.165414735497;877.2587163846539;892.1168043636818;895.154079394972;903.056306160061;891.3671293381674;895.6014573514789;896.085992287866;896.4038914122101;897.5826240798027;952.4570994533084;953.3612479638658;953.718652997364;953.7663272498247;954.4607296877277;782.9256220659029;943.5423819447562;944.2304521814699;957.0094951725001;957.2150836314225;698.6052880122714;700.6951975890453;704.102269606251;705.865885481762;705.9082319298458;14494.275286235646;14532.636684082876;14548.127112373186;14576.198309092995;14696.338664760111;14749.926250368786;15207.391704331923;15268.618284542865;15359.692806143814;15382.461613843574;11754;11783.7054073648;11970;12048;12268.81596776049;4081.285774989365;4095.303798354257;4113.197926404352;4166.687498437599;4216.156768646252;55016.44983550153;55113.89772204574;56078.43921560773;56099.43900560983;56126;11774.705632359259;11812.763744725058;12075.45660445282;12180.156528138185;12261.386930653433;21829.563408732054;21851.344459666234;21895.452613684785;21922.23272185466;21943.780562194494;9053.321000924825;9060.728178154666;9065.184133428023;9142.81714365709;9147.039560846148;4960.578350840219;4996.2505624156665;5045.192769156991;5058.114829904752;5070.29015937769;3565.7860528368383;3607.2424790793702;3634.5093412388987;3639.70882329413;3640.5995340512522;628.8207860759661;638.0684201066402;720.1897864901986;733.0397179694511;742.2169611060383;710.7476845719798;811.9512829230265;819.2708489444399;820.3683163963715;840.7982084299724;9577.952110239543;9800.852987205197;10135.189184865194;10153.644622438327;10161.288709790391;628.2680677011322;724.1129616220088;742.506233354813;748.0574476159969;748.3190296829858;4618.1918164321105;4806.206975848946;4884.902301953941;4932.654714170046;5024.346834911438;59119;59327.70336148378;59631.70184149052;59817.700911495165;59870;53866;54648.45351546434;55498.445015549325;56428;56496.43503564994;50044.49955500398;50818.237726434134;51028.23457648138;53166.73416632892;53839.730801345744;9959.601615935282;10015.449150296803;10084.647037353658;10257.17942564608;10454.68635940923;37916.62083379131;38554.80722596369;38930;38932.41601375925;39683;47941.76029119832;49144.75427622982;49596.50403495919;50088.74955625198;50567.74716126396;11901.464434100313;12051;12529.122961392615;12671.429785659851;12801.61595152147;13943.302834858014;13947;14910.77633835515;14950.92524537414;15143.697126057197;13432.798508022583;13837.377318020512;13845.376958037114;14273.357698903366;14344.856551434352;13920.58238252854;14387.064840785315;14540.85459145395;14783.926080369529;15136.924315378352;13390.26353550564;13891.305434728425;13917.930410347883;14756.188409637143;15117.622059448602;11241.55033798639;11419.37193454368;11536.36549989725;11675.766484670428;11812.468438920097;11015.669529914116;11466.885331146581;11545.480453379787;12008.099392545419;12425.875741242471 03:42:42 INFO - PROCESS | 13359 | __end_tp_report 03:42:42 INFO - PROCESS | 13359 | __start_cc_report 03:42:42 INFO - PROCESS | 13359 | _x_x_mozilla_cycle_collect,832 03:42:42 INFO - PROCESS | 13359 | __end_cc_report 03:42:42 INFO - PROCESS | 13359 | __startTimestamp1464691362291__endTimestamp 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | ------- Summary: start ------- 03:42:42 INFO - PROCESS | 13359 | Number of tests: 6 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#0] dojo.html Cycles:165 Average:5492.53 Median:5686.97 stddev:610.87 (10.7%) stddev-sans-first:588.81 03:42:42 INFO - PROCESS | 13359 | Values: 3334.5 3376.3 3377.6 3394.6 3417.1 5529.0 5530.1 5539.4 5544.5 5549.8 5545.3 5556.4 5582.8 5593.9 5661.4 4968.0 4978.2 5145.3 5185.4 5225.9 4952.0 5020.5 5024.6 5024.8 5035.1 5022.2 5032.5 5034.4 5060.8 5080.9 5068.9 5088.8 5126.2 5134.4 5161.5 4939.1 4961.7 5031.1 5048.1 5063.3 5384.1 5430.6 5450.2 5457.3 5472.2 5854.3 5855.7 5859.6 5904.5 5904.8 5852.2 5922.0 5937.3 5964.3 5979.6 5493.9 5514.8 5528.7 5533.3 5539.8 5981.9 6001.9 6011.7 6016.7 6020.9 5800.2 5813.3 5853.6 5858.5 5858.8 5889.2 5902.0 5903.1 5904.2 5906.8 5793.5 5822.7 5832.7 5872.1 5881.4 5845.8 5850.5 5852.4 5877.2 5896.4 4407.5 4407.7 4408.4 4411.0 4434.0 3897.7 3929.2 3943.7 3977.9 4003.5 5650.0 5661.9 5669.9 5675.8 5681.8 5942.6 5956.0 5957.8 5957.8 5958.5 5550.5 5576.1 5626.2 5651.5 5683.0 5083.7 5087.9 5090.7 5112.4 5114.3 6163.5 6166.0 6168.6 6169.9 6170.8 5895.1 5908.9 5916.9 5975.6 6089.5 6178.7 6195.2 6196.5 6200.9 6202.4 5750.3 5754.7 5756.2 5764.1 5824.0 5851.9 5852.5 5921.6 5928.6 5935.9 5671.2 5732.9 5742.7 5744.3 5750.8 5687.0 5740.5 5740.6 5740.9 5743.4 5628.0 5631.1 5693.6 5723.0 5734.4 5742.8 5760.3 5775.5 5775.7 5783.3 5600.0 5643.5 5646.9 5651.7 5702.9 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#1] ext.html Cycles:180 Average:57333.67 Median:204616.91 stddev:111248.08 (54.4%) stddev-sans-first:111478.81 03:42:42 INFO - PROCESS | 13359 | Values: 670.7 683.1 684.4 726.9 742.0 32299.4 32838.0 39382.0 39853.2 39925.6 43261.0 43700.3 43790.3 43802.8 43914.8 7954.6 8795.6 8956.5 8974.1 10232.8 10242.6 10363.9 10366.8 10372.6 10379.9 10363.1 10401.6 10415.2 10432.4 10432.5 10299.6 10336.8 10347.5 10360.5 10369.6 10243.8 10262.2 10369.4 10710.0 10730.9 43223.8 43300.1 43582.6 43749.6 43765.1 3954.3 3990.5 4014.0 4095.3 4139.7 33220.0 33400.2 33436.8 33491.3 33640.0 4338.3 4408.3 4413.6 4453.6 4467.6 324556.0 326282.0 329452.0 331387.0 331883.3 40999.4 61788.7 62613.4 62685.4 62714.0 39638.0 39685.8 39809.0 39869.8 39877.0 17118.9 17332.0 17379.0 17386.8 17396.5 13471.4 14647.2 14875.4 14908.7 14925.5 9061.5 9078.5 9088.9 9139.9 9183.1 3444.4 3563.3 3567.9 3575.1 3590.0 1127.0 1128.9 1146.7 1229.8 1236.0 33435.3 34271.8 36531.5 37508.4 38059.8 1217.1 1226.6 1240.0 1259.1 1290.4 16488.7 16927.3 16957.3 17102.4 17219.6 500270.0 505578.0 505726.0 506033.0 506044.0 60800.0 61382.0 61467.1 61478.4 61512.0 1399.5 1488.7 1552.6 1560.1 1560.2 29302.0 30018.4 32334.7 33208.3 33632.8 50795.5 51324.2 51449.5 51457.5 51483.7 372352.0 379129.0 379141.0 380390.0 512972.0 29813.4 30015.2 30285.4 30594.8 30634.7 47398.8 47764.3 48293.3 48526.5 48776.8 40654.8 40751.0 40772.8 41008.4 41028.4 37982.0 38974.4 39970.4 40386.4 40504.0 40632.0 41641.4 41712.4 42109.4 42609.8 34818.3 35557.8 36402.6 36644.5 36881.8 27914.4 28133.9 28309.9 28511.9 28550.0 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#2] jquery.html Cycles:180 Average:27345.62 Median:23206.98 stddev:69969.15 (301.5%) stddev-sans-first:70136.20 03:42:42 INFO - PROCESS | 13359 | Values: 406.7 414.9 416.8 422.0 423.5 13613.0 18421.9 18948.8 19013.3 20511.0 15621.9 18282.4 18766.0 19119.7 19245.9 5589.7 5757.2 5760.2 5780.5 5780.5 5650.5 5716.0 5749.2 5761.3 5762.7 4185.2 6031.4 6281.9 6291.3 6295.5 6178.1 6214.8 6221.9 6229.6 6230.6 5526.9 5732.5 5736.8 5750.9 5764.6 22863.7 22994.3 23419.6 23701.8 23775.2 2573.6 2642.2 2670.5 2691.5 3105.7 14430.1 14755.0 15085.4 15359.7 15488.4 1990.8 2046.2 2126.1 2134.5 2198.3 84010.0 89594.0 91476.5 91800.5 93069.0 11452.5 11519.2 11547.0 11622.7 11732.2 16223.4 16314.2 16490.1 16492.7 16507.4 8433.6 8616.5 8662.4 8696.6 8715.9 8361.7 8371.6 8377.3 8428.2 8446.4 4601.4 4749.2 5015.9 5059.3 5089.6 2044.2 2073.5 2082.8 2093.1 2118.7 1004.2 1045.5 1070.8 1150.8 1156.1 17926.5 17931.3 18550.7 19088.8 19216.8 1059.9 1102.9 1119.0 1144.0 1147.7 10204.4 10931.8 11050.9 11077.9 11151.7 355995.0 356693.0 357066.0 494985.0 509739.0 77018.1 77247.0 88030.0 92531.5 93586.0 1101.5 1109.5 1121.1 1132.2 1153.1 17117.0 17268.3 17390.0 17415.7 17445.4 40313.8 41559.6 42053.2 43577.1 43764.6 61047.0 61143.4 61414.4 61460.4 61523.0 8784.0 8894.9 9028.5 9210.2 9256.7 9424.8 12530.4 12769.7 13140.6 13336.6 11661.7 11725.1 11898.8 12078.5 12250.4 11970.8 12067.6 12135.9 12143.0 12188.6 12482.3 12543.7 12580.9 12622.7 12760.7 8623.7 8901.9 8915.2 8994.0 9000.3 11891.4 12282.1 12369.7 12443.8 12619.7 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#3] mootools.html Cycles:180 Average:5692.89 Median:5013.41 stddev:3140.05 (62.6%) stddev-sans-first:3131.80 03:42:42 INFO - PROCESS | 13359 | Values: 1339.1 1569.6 1607.3 1820.0 1931.9 7454.8 8233.0 8366.3 8420.2 8437.2 8204.3 8353.8 8370.2 8378.5 8383.3 2133.9 2172.1 2428.1 2451.2 2472.9 2400.9 2415.2 2419.8 2421.7 2422.2 2312.4 2361.3 2365.2 2397.3 2405.2 2129.2 2331.0 2403.0 2443.2 2452.6 2354.3 2358.1 2376.3 2378.6 2381.3 8038.6 8040.2 8100.6 8110.0 8116.7 5287.8 5353.2 5374.5 5375.1 5380.4 3603.5 3610.7 3737.2 3757.0 3758.3 1180.2 1192.5 1196.5 1215.9 1221.5 12140.2 12221.5 12223.0 12257.1 12274.6 4810.5 4817.3 4823.3 4830.6 4894.8 10231.6 10241.9 10277.4 10279.1 10286.8 5515.2 5520.6 5531.7 5536.0 5538.6 4435.9 4888.2 4992.8 5011.1 5015.7 4157.2 4174.9 4176.2 4194.1 4226.2 1350.6 1367.4 1373.5 1381.6 1389.5 851.8 941.3 1051.9 1063.5 1069.3 6014.7 6087.6 6100.7 6130.6 6135.7 494.1 494.4 498.1 506.1 507.2 4044.3 4133.8 4177.3 4222.7 4227.9 10331.9 10686.1 10737.1 10768.1 10780.4 10567.2 10590.8 10607.5 10610.9 10624.9 8191.0 8265.1 8268.1 8271.2 8274.0 5720.9 5738.5 5743.5 5755.2 5876.1 9397.2 9550.3 9657.8 9687.6 9696.2 8944.8 9228.7 9777.4 9782.6 9803.7 6785.5 7126.1 7297.9 7403.4 7491.1 8097.2 8124.1 8127.7 8138.1 8172.5 7001.4 7161.9 7201.1 7274.7 7302.1 7128.8 7221.3 7241.7 7431.2 7594.7 6832.8 6833.2 6865.1 6890.9 6893.1 4870.5 5090.2 5128.7 5131.6 5137.8 5322.2 5353.6 5394.5 5417.8 5452.5 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#4] prototype.html Cycles:180 Average:5450.22 Median:6284.06 stddev:1640.67 (26.1%) stddev-sans-first:1599.72 03:42:42 INFO - PROCESS | 13359 | Values: 335.5 337.2 346.4 351.2 351.8 6183.7 6211.6 6229.4 6241.1 6254.1 5835.9 6007.8 6087.1 6091.6 6122.3 4680.3 4692.8 4728.0 4744.9 4758.1 4760.9 4761.7 4769.6 4771.0 4779.2 4501.5 4585.4 4708.3 4719.4 4728.8 4694.2 4699.1 4712.9 4713.3 4718.8 4126.3 4147.2 4150.5 4150.6 4151.8 5982.8 5985.4 5987.9 5991.1 6001.5 5481.0 5492.1 5497.9 5498.4 5506.2 6363.7 6474.1 6497.4 6515.7 6535.7 4597.4 4603.2 4608.6 4610.1 4618.1 6814.2 6816.9 6824.6 6828.8 6834.4 4702.7 4707.4 4717.1 4718.4 4720.0 4762.2 4774.0 4774.6 4776.4 4777.7 5160.2 5303.8 5486.7 5499.0 5501.6 6502.2 6510.4 6514.9 6561.8 6572.5 1530.0 1582.2 1594.1 1611.8 1617.6 1036.5 1044.4 1046.0 1049.8 1052.1 6273.7 6294.4 6295.4 6364.7 6369.6 6699.5 6706.0 6707.5 6721.2 6727.1 6317.0 6325.1 6340.7 6356.2 6365.6 3566.2 3598.4 3602.2 3602.9 3603.0 6815.8 6919.9 6963.1 6972.9 6980.6 6720.8 6727.0 6735.0 6751.6 6757.0 6910.7 6926.4 6928.8 6941.1 6943.8 6586.0 6596.1 6600.8 6605.8 6608.2 6319.2 6516.6 6522.5 6523.1 6541.8 6914.2 6947.0 6952.8 6954.0 6968.5 4495.8 4502.1 4505.9 4507.7 4507.9 6476.7 6542.9 6590.4 6594.7 6597.2 6416.7 6462.1 6499.3 6525.1 6535.9 6487.1 6498.3 6510.2 6514.4 6521.0 6409.6 6436.5 6480.1 6483.2 6497.7 6452.5 6619.6 6624.0 6635.6 6650.6 6445.8 6470.5 6473.7 6479.3 6485.1 03:42:42 INFO - PROCESS | 13359 | 03:42:42 INFO - PROCESS | 13359 | [#5] yui.html Cycles:180 Average:15640.41 Median:4191.42 stddev:17377.32 (414.6%) stddev-sans-first:17390.41 03:42:42 INFO - PROCESS | 13359 | Values: 816.2 867.5 919.7 920.0 937.0 14877.6 15319.3 15364.2 15368.4 15368.8 14230.9 14261.2 14301.9 14303.0 14324.5 745.2 877.3 892.1 895.2 903.1 891.4 895.6 896.1 896.4 897.6 952.5 953.4 953.7 953.8 954.5 782.9 943.5 944.2 957.0 957.2 698.6 700.7 704.1 705.9 705.9 14494.3 14532.6 14548.1 14576.2 14696.3 14749.9 15207.4 15268.6 15359.7 15382.5 11754.0 11783.7 11970.0 12048.0 12268.8 4081.3 4095.3 4113.2 4166.7 4216.2 55016.4 55113.9 56078.4 56099.4 56126.0 11774.7 11812.8 12075.5 12180.2 12261.4 21829.6 21851.3 21895.5 21922.2 21943.8 9053.3 9060.7 9065.2 9142.8 9147.0 4960.6 4996.3 5045.2 5058.1 5070.3 3565.8 3607.2 3634.5 3639.7 3640.6 628.8 638.1 720.2 733.0 742.2 710.7 812.0 819.3 820.4 840.8 9578.0 9800.9 10135.2 10153.6 10161.3 628.3 724.1 742.5 748.1 748.3 4618.2 4806.2 4884.9 4932.7 5024.3 59119.0 59327.7 59631.7 59817.7 59870.0 53866.0 54648.5 55498.4 56428.0 56496.4 50044.5 50818.2 51028.2 53166.7 53839.7 9959.6 10015.4 10084.6 10257.2 10454.7 37916.6 38554.8 38930.0 38932.4 39683.0 47941.8 49144.8 49596.5 50088.7 50567.7 11901.5 12051.0 12529.1 12671.4 12801.6 13943.3 13947.0 14910.8 14950.9 15143.7 13432.8 13837.4 13845.4 14273.4 14344.9 13920.6 14387.1 14540.9 14783.9 15136.9 13390.3 13891.3 13917.9 14756.2 15117.6 11241.6 11419.4 11536.4 11675.8 11812.5 11015.7 11466.9 11545.5 12008.1 12425.9 03:42:42 INFO - PROCESS | 13359 | -------- Summary: end -------- 03:42:42 INFO - PROCESS | 13359 | 03:42:43 INFO - TEST-INFO | 13359: exit 0 03:42:43 INFO - TEST-OK | dromaeo_css | took 1113317ms 03:42:43 INFO - TEST-START | kraken 03:42:43 INFO - operating with platform_type : linux_ 03:42:43 INFO - Initialising browser for kraken test... 03:42:43 INFO - TEST-INFO | started process 13552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEfDwg/profile http://localhost:51670/getInfo.html) 03:42:48 INFO - PROCESS | 13552 | __metrics Screen width/height:1600/1200 03:42:48 INFO - PROCESS | 13552 | colorDepth:24 03:42:48 INFO - PROCESS | 13552 | Browser inner width/height: 1024/697 03:42:48 INFO - PROCESS | 13552 | __metrics 03:42:49 ERROR - PROCESS | 13552 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:42:50 INFO - TEST-INFO | 13552: exit 0 03:42:50 INFO - Browser initialized. 03:42:50 INFO - Running cycle 1/1 for kraken test... 03:42:50 INFO - TEST-INFO | started process 13645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxEfDwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:02 INFO - PROCESS | 13645 | RSS: Main: 142467072 03:43:02 INFO - PROCESS | 13645 | 03:43:04 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51670/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:05 INFO - PROCESS | 13645 | RSS: Main: 197103616 03:43:05 INFO - PROCESS | 13645 | 03:43:08 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51670/tests/kraken/driver.html?testName=audio-dft) 03:43:08 INFO - PROCESS | 13645 | RSS: Main: 180977664 03:43:08 INFO - PROCESS | 13645 | 03:43:11 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51670/tests/kraken/driver.html?testName=audio-fft) 03:43:12 INFO - PROCESS | 13645 | RSS: Main: 272384000 03:43:12 INFO - PROCESS | 13645 | 03:43:14 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51670/tests/kraken/driver.html?testName=audio-oscillator) 03:43:14 INFO - PROCESS | 13645 | RSS: Main: 178139136 03:43:14 INFO - PROCESS | 13645 | 03:43:16 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51670/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:17 INFO - PROCESS | 13645 | RSS: Main: 176820224 03:43:17 INFO - PROCESS | 13645 | 03:43:20 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51670/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:21 INFO - PROCESS | 13645 | RSS: Main: 211374080 03:43:21 INFO - PROCESS | 13645 | 03:43:24 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51670/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:25 INFO - PROCESS | 13645 | RSS: Main: 211689472 03:43:25 INFO - PROCESS | 13645 | 03:43:27 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51670/tests/kraken/driver.html?testName=json-parse-financial) 03:43:28 INFO - PROCESS | 13645 | RSS: Main: 211628032 03:43:28 INFO - PROCESS | 13645 | 03:43:30 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51670/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:30 INFO - PROCESS | 13645 | RSS: Main: 191991808 03:43:30 INFO - PROCESS | 13645 | 03:43:32 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:32 INFO - PROCESS | 13645 | RSS: Main: 195792896 03:43:32 INFO - PROCESS | 13645 | 03:43:34 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:35 INFO - PROCESS | 13645 | RSS: Main: 207851520 03:43:35 INFO - PROCESS | 13645 | 03:43:37 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:38 INFO - PROCESS | 13645 | RSS: Main: 212865024 03:43:38 INFO - PROCESS | 13645 | 03:43:41 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:41 INFO - PROCESS | 13645 | RSS: Main: 210886656 03:43:41 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | Cycle 1(1): loaded http://localhost:51670/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51670/tests/kraken/driver.html?testName=ai-astar) 03:43:43 INFO - PROCESS | 13645 | RSS: Main: 274268160 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | __start_tp_report 03:43:43 INFO - PROCESS | 13645 | _x_x_mozilla_page_load 03:43:43 INFO - PROCESS | 13645 | _x_x_mozilla_page_load_details 03:43:43 INFO - PROCESS | 13645 | |i|pagename|runs| 03:43:43 INFO - PROCESS | 13645 | |0;ai-astar;110;110;109;111;111;110;105;110;110;109 03:43:43 INFO - PROCESS | 13645 | |1;audio-beat-detection;151;126;152;171;136;163;149;126;171;126 03:43:43 INFO - PROCESS | 13645 | |2;audio-dft;163;162;162;163;163;163;163;164;164;159 03:43:43 INFO - PROCESS | 13645 | |3;audio-fft;76;74;77;170;76;76;74;72;158;75 03:43:43 INFO - PROCESS | 13645 | |4;audio-oscillator;90;91;149;92;91;92;157;92;92;145 03:43:43 INFO - PROCESS | 13645 | |5;imaging-gaussian-blur;117;117;117;124;116;116;117;117;116;116 03:43:43 INFO - PROCESS | 13645 | |6;imaging-darkroom;146;145;144;145;146;145;146;145;146;146 03:43:43 INFO - PROCESS | 13645 | |7;imaging-desaturate;95;95;94;94;95;94;94;94;95;94 03:43:43 INFO - PROCESS | 13645 | |8;json-parse-financial;58;54;54;55;53;55;56;76;54;53 03:43:43 INFO - PROCESS | 13645 | |9;json-stringify-tinderbox;58;59;58;59;58;58;59;59;59;59 03:43:43 INFO - PROCESS | 13645 | |10;stanford-crypto-aes;82;73;71;73;73;74;73;73;73;73 03:43:43 INFO - PROCESS | 13645 | |11;stanford-crypto-ccm;114;118;118;113;117;112;114;114;133;126 03:43:43 INFO - PROCESS | 13645 | |12;stanford-crypto-pbkdf2;157;156;157;159;158;164;160;157;162;161 03:43:43 INFO - PROCESS | 13645 | |13;stanford-crypto-sha256-iterative;66;67;67;66;65;64;78;65;65;64 03:43:43 INFO - PROCESS | 13645 | __end_tp_report 03:43:43 INFO - PROCESS | 13645 | __start_cc_report 03:43:43 INFO - PROCESS | 13645 | _x_x_mozilla_cycle_collect,1618 03:43:43 INFO - PROCESS | 13645 | __end_cc_report 03:43:43 INFO - PROCESS | 13645 | __startTimestamp1464691423814__endTimestamp 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | ------- Summary: start ------- 03:43:43 INFO - PROCESS | 13645 | Number of tests: 14 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.72 (1.6%) stddev-sans-first:1.81 03:43:43 INFO - PROCESS | 13645 | Values: 110.0 110.0 109.0 111.0 111.0 110.0 105.0 110.0 110.0 109.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.50 stddev:17.94 (11.8%) stddev-sans-first:18.97 03:43:43 INFO - PROCESS | 13645 | Values: 151.0 126.0 152.0 171.0 136.0 163.0 149.0 126.0 171.0 126.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 03:43:43 INFO - PROCESS | 13645 | Values: 163.0 162.0 162.0 163.0 163.0 163.0 163.0 164.0 164.0 159.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:37.66 (49.9%) stddev-sans-first:39.45 03:43:43 INFO - PROCESS | 13645 | Values: 76.0 74.0 77.0 170.0 76.0 76.0 74.0 72.0 158.0 75.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:91.50 stddev:28.61 (31.3%) stddev-sans-first:29.49 03:43:43 INFO - PROCESS | 13645 | Values: 90.0 91.0 149.0 92.0 91.0 92.0 157.0 92.0 92.0 145.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:2.41 (2.1%) stddev-sans-first:2.55 03:43:43 INFO - PROCESS | 13645 | Values: 117.0 117.0 117.0 124.0 116.0 116.0 117.0 117.0 116.0 116.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 03:43:43 INFO - PROCESS | 13645 | Values: 146.0 145.0 144.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:43:43 INFO - PROCESS | 13645 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:55.00 stddev:6.91 (12.6%) stddev-sans-first:7.31 03:43:43 INFO - PROCESS | 13645 | Values: 58.0 54.0 54.0 55.0 53.0 55.0 56.0 76.0 54.0 53.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 03:43:43 INFO - PROCESS | 13645 | Values: 58.0 59.0 58.0 59.0 58.0 58.0 59.0 59.0 59.0 59.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.97 (4.1%) stddev-sans-first:0.78 03:43:43 INFO - PROCESS | 13645 | Values: 82.0 73.0 71.0 73.0 73.0 74.0 73.0 73.0 73.0 73.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.50 stddev:6.66 (5.7%) stddev-sans-first:6.91 03:43:43 INFO - PROCESS | 13645 | Values: 114.0 118.0 118.0 113.0 117.0 112.0 114.0 114.0 133.0 126.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:2.60 (1.6%) stddev-sans-first:2.65 03:43:43 INFO - PROCESS | 13645 | Values: 157.0 156.0 157.0 159.0 158.0 164.0 160.0 157.0 162.0 161.0 03:43:43 INFO - PROCESS | 13645 | 03:43:43 INFO - PROCESS | 13645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:4.11 (6.2%) stddev-sans-first:4.35 03:43:43 INFO - PROCESS | 13645 | Values: 66.0 67.0 67.0 66.0 65.0 64.0 78.0 65.0 65.0 64.0 03:43:43 INFO - PROCESS | 13645 | -------- Summary: end -------- 03:43:43 INFO - PROCESS | 13645 | 03:43:44 INFO - TEST-INFO | 13645: exit 0 03:43:44 INFO - TEST-OK | kraken | took 61688ms 03:43:44 INFO - SUITE-END | took 1175s 03:43:44 INFO - Completed test suite (00:19:35) 03:43:44 INFO - javascript benchmark 03:43:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.4831551109573, 3376.27410106827, 3377.6115746689125, 3394.6435624259443, 3417.0603084151853, 5529.0, 5530.142827861688, 5539.446055394458, 5544.528715059219, 5549.833504994852, 5545.306836645419, 5556.361018482876, 5582.804601838937, 5593.888122237553, 5661.405552416988, 4967.950320496803, 4978.178600530908, 5145.253938178962, 5185.377754669426, 5225.8954820903555, 4951.950480495203, 5020.472850350716, 5024.598032157419, 5024.773885175157, 5035.144025515671, 5022.19644856823, 5032.4967503249745, 5034.446210916796, 5060.84817455477, 5080.923786143211, 5068.923966140511, 5088.771005304751, 5126.231065340192, 5134.409542902539, 5161.509656582619, 4939.086269040239, 4961.652684312099, 5031.119554078058, 5048.066107770038, 5063.291139240509, 5384.057789886754, 5430.59270554706, 5450.182472629098, 5457.263269458612, 5472.206530053159, 5854.297484301911, 5855.707214639294, 5859.648421094748, 5904.498117660004, 5904.822855314347, 5852.209951656514, 5921.970390148064, 5937.346891841894, 5964.343922168558, 5979.581429299951, 5493.917591236134, 5514.834554963358, 5528.7235638218735, 5533.280673512418, 5539.806106786284, 5981.850453738604, 6001.879962400728, 6011.729472173763, 6016.669083200379, 6020.909686354708, 5800.158976948319, 5813.273340832396, 5853.560982926298, 5858.472737453564, 5858.8242352729485, 5889.1755154278435, 5902.026165682701, 5903.0555111182, 5904.202932604044, 5906.793262235801, 5793.478586927196, 5822.7088645567555, 5832.737526811304, 5872.060470324727, 5881.411858814085, 5845.795397161079, 5850.47345738877, 5852.444017818386, 5877.23595932526, 5896.351401345849, 4407.493138289074, 4407.6914615976575, 4408.448943882015, 4411.0, 4434.0, 3897.707671924617, 3929.155231625214, 3943.7042221833476, 3977.880663580097, 4003.539592946848, 5649.971750141223, 5661.943380566142, 5669.943300566942, 5675.772969081273, 5681.772729090872, 5942.58401911862, 5956.0, 5957.791477298274, 5957.79147729836, 5958.523318134538, 5550.47270509301, 5576.079946808813, 5626.212330273765, 5651.463111004448, 5683.0338842396895, 5083.669561478492, 5087.87280317995, 5090.745462726849, 5112.4120726116225, 5114.33513643224, 6163.476104531075, 6166.0, 6168.599041062316, 6169.938300616936, 6170.845728856725, 5895.115732640138, 5908.852278693067, 5916.911246331395, 5975.611585246945, 6089.451949324582, 6178.69106544662, 6195.1636529068, 6196.504279657526, 6200.906986395298, 6202.441780239619, 5750.338711048115, 5754.683492407958, 5756.222909907109, 5764.106563482667, 5824.0, 5851.912221316598, 5852.5317974561085, 5921.585489015728, 5928.644281343133, 5935.940640593712, 5671.206031155559, 5732.942670573241, 5742.712864356682, 5744.3394009687745, 5750.827475175752, 5686.9715651421475, 5740.483356497935, 5740.598158129058, 5740.856478588069, 5743.368229494668, 5628.0, 5631.127175287673, 5693.629914055573, 5723.0, 5734.3978882218435, 5742.799002034909, 5760.337561180518, 5775.48020678141, 5775.7400916957995, 5783.306003279465, 5600.047991841316, 5643.492085712305, 5646.88706225865, 5651.745671444877, 5702.942970570241], "value": 5452.785263419345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.6546128743698, 683.0914883205337, 684.4079870911661, 726.9023774101106, 741.9925800741994, 32299.354012919757, 32838.0, 39381.99999999996, 39853.20293594126, 39925.60074399255, 43261.0, 43700.3444948326, 43790.34314485277, 43802.78098609502, 43914.78042609782, 7954.562499062549, 8795.560221988906, 8956.507392093432, 8974.05772393899, 10232.846507302396, 10242.641507547238, 10363.948180259089, 10366.844497332546, 10372.636957706482, 10379.896201038006, 10363.119134873545, 10401.583936642524, 10415.16678665705, 10432.374057556572, 10432.478376081204, 10299.63951261706, 10336.844947325833, 10347.482625868752, 10360.533775980099, 10369.585216591327, 10243.84634230487, 10262.230332725076, 10369.377837329785, 10710.03609675133, 10730.892691073068, 43223.78388108071, 43300.13399731988, 43582.564174358486, 43749.562504374866, 43765.12469750619, 3954.268460334847, 3990.541087774914, 4013.999999999971, 4095.28332541804, 4139.710220284582, 33220.0, 33400.16499587506, 33436.83281583601, 33491.33017339664, 33640.0, 4338.3058710606465, 4408.316710909814, 4413.602775750198, 4453.621442177418, 4467.620252278561, 324556.0, 326282.0, 329452.0, 331387.0, 331883.34058329795, 40999.38500922488, 61788.69105654533, 62613.37386626167, 62685.37314626887, 62714.0, 39638.0, 39685.80157099254, 39809.0, 39869.800650996556, 39877.0, 17118.914405427895, 17332.0, 17379.0, 17386.826131738522, 17396.47810565685, 13471.393787279596, 14647.194404307866, 14875.404983800527, 14908.70182596342, 14925.477608283658, 9061.456312621263, 9078.54607269634, 9088.909110908806, 9139.862902056475, 9183.081691830897, 3444.4488881778793, 3563.2695297463956, 3567.8929632111076, 3575.0526110580195, 3589.964100359015, 1127.0082327551702, 1128.8870420389107, 1146.7247860513417, 1229.8339724137127, 1235.9876401236052, 33435.331293373994, 34271.828640856635, 36531.452028219595, 37508.43737343942, 38059.809700951315, 1217.1358335581835, 1226.6320103968774, 1240.0203838967295, 1259.0934527140444, 1290.3806173036994, 16488.658831009972, 16927.322907083824, 16957.321707131825, 17102.401415950382, 17219.56951076208, 500270.0, 505578.0, 505726.0, 506033.0, 506044.0, 60800.0, 61382.0, 61467.07799383013, 61478.38521614816, 61512.0, 1399.4961813747043, 1488.6501672107047, 1552.6196081959993, 1560.1263292556205, 1560.2432820082252, 29302.0, 30018.3996320068, 32334.676653234106, 33208.33583328368, 33632.83183584066, 50795.492045079074, 51324.23013654724, 51449.48550514447, 51457.48542514527, 51483.74258128685, 372352.0, 379129.0, 379141.0, 380390.0, 512972.0, 29813.403731925675, 30015.249618759706, 30285.394292114474, 30594.84702576562, 30634.693653063183, 47398.76300618613, 47764.28353574769, 48293.309734159135, 48526.5147348522, 48776.75611622061, 40654.79672601618, 40751.0, 40772.79613601913, 41008.38487422751, 41028.38457423081, 37982.0, 38974.4153837687, 39970.40044399278, 40386.39420408638, 40504.0, 40632.0, 41641.375379369936, 41712.3743143847, 42109.368359475244, 42609.78695106505, 34818.30363392769, 35557.82221088981, 36402.635973639924, 36644.45033324556, 36881.81559092188, 27914.44171116607, 28133.859330703217, 28309.858450708438, 28511.857440712665, 28550.0], "value": 19852.382523794702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.74578388507183, 414.88383252689243, 416.843683618643, 422.0061754567992, 423.4727763933903, 13612.976821019656, 18421.907890460545, 18948.810511894895, 19013.33453329132, 20511.0, 15621.92189039056, 18282.360117395892, 18766.0, 19119.71320430195, 19245.903770481164, 5589.664620122785, 5757.193992841006, 5760.193572899777, 5780.450857168583, 5780.537556995451, 5650.51970582501, 5716.0, 5749.166370876221, 5761.30864296285, 5762.654240745548, 4185.183889141618, 6031.366706495821, 6281.905771413432, 6291.276503202122, 6295.527835412339, 6178.10417489466, 6214.844628884269, 6221.937780622181, 6229.626222426669, 6230.626162430269, 5526.944730552724, 5732.5127364174095, 5736.827895163152, 5750.913736293959, 5764.596478246524, 22863.657045144337, 22994.310170694906, 23419.648705269436, 23701.762982370128, 23775.16786912467, 2573.61395790631, 2642.2469596165, 2670.5326567850548, 2691.5155272051024, 3105.6894310568987, 14430.134191948517, 14755.0, 15085.39658413662, 15359.692806143814, 15488.380464781396, 1990.8307793837396, 2046.2019812273224, 2126.0857831132607, 2134.466383404149, 2198.2525941179915, 84010.0, 89594.0, 91476.54261728715, 91800.54099729525, 93068.99999999932, 11452.484638191134, 11519.19365644397, 11547.0, 11622.70943226426, 11732.178747487595, 16223.432179873647, 16314.184290785413, 16490.093044882407, 16492.67014659724, 16507.422240221775, 8433.578321083922, 8616.48301101936, 8662.350323725746, 8696.608652610648, 8715.912840871637, 8361.749147525585, 8371.58142092893, 8377.287930525852, 8428.157184281645, 8446.408751387344, 4601.3558101865765, 4749.192637251606, 5015.924761128586, 5059.266406371055, 5089.618278629117, 2044.2231951858496, 2073.5438203595186, 2082.8031516494275, 2093.120889226498, 2118.6504226802713, 1004.1765752083368, 1045.46158728255, 1070.8179609466254, 1150.810116330813, 1156.115571587736, 17926.462206133838, 17931.282748690166, 18550.72173917392, 19088.80911190898, 19216.807831921782, 1059.9470026498643, 1102.8566286382718, 1118.9608363707232, 1143.988560114405, 1147.6958605969426, 10204.38773673567, 10931.836022459669, 11050.944745276383, 11077.944610277058, 11151.665450036511, 355995.0, 356693.0, 357066.0, 494985.0, 509739.0, 77018.08777789392, 77247.0, 88030.0, 92531.5373423142, 93586.0, 1101.54285971321, 1109.5395410904546, 1121.1311233793874, 1132.1621999720148, 1153.140910022039, 17117.0, 17268.309267629153, 17389.956757567626, 17415.651686965935, 17445.389411370543, 40313.79843100766, 41559.58440415678, 42053.1589368217, 43577.12845743004, 43764.56235437605, 61047.0, 61143.38856611555, 61414.38585614265, 61460.385396145466, 61523.0, 8784.0, 8894.866577001221, 9028.503432311287, 9210.171084602418, 9256.676016339396, 9424.764380890532, 12530.37348132608, 12769.744605108031, 13140.60578182656, 13336.599902002956, 11661.6501504955, 11725.061995040205, 11898.821517677416, 12078.51685932553, 12250.387480626112, 11970.772296612118, 12067.57763478274, 12135.939320303341, 12143.0, 12188.57339993096, 12482.251064936132, 12543.749125017632, 12580.937095314464, 12622.684432889251, 12760.74478510406, 8623.65505379803, 8901.910980890108, 8915.197632213132, 8993.955030224806, 9000.324975626985, 11891.405429728651, 12282.140250182401, 12369.690757731129, 12443.813342799684, 12619.74760504803], "value": 9599.350454332382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.129565782241, 1569.5919061044126, 1607.3249235321168, 1819.9727004094932, 1931.9130639121238, 7454.776356709301, 8233.0, 8366.28886544643, 8420.157984201593, 8437.240648341649, 8204.261616454518, 8353.791155221123, 8370.162983701626, 8378.497290162595, 8383.329333653308, 2133.8826364549946, 2172.142003908455, 2428.0530593068715, 2451.240115564172, 2472.9010839566395, 2400.927972160838, 2415.2150551070886, 2419.842710223839, 2421.7457166997388, 2422.2491027781357, 2312.4218945263683, 2361.3152185866165, 2365.207655435431, 2397.280815755275, 2405.194259922919, 2129.20154941896, 2331.0, 2402.987985060081, 2443.1815341860497, 2452.5953217719057, 2354.3172479980785, 2358.0921345282018, 2376.3346263046374, 2378.619420892649, 2381.2618088392655, 8038.557879316635, 8040.2361775631225, 8100.554469504175, 8110.026796784424, 8116.675332986673, 5287.814926477555, 5353.170258609922, 5374.48942350476, 5375.139977603565, 5380.408155102936, 3603.513525674027, 3610.711143108545, 3737.1591391936595, 3757.0419543016355, 3758.2859256741403, 1180.167981572989, 1192.5349113845607, 1196.521391443421, 1215.8601760797444, 1221.45034734369, 12140.210886292363, 12221.450034748457, 12223.0, 12257.080718946025, 12274.631761047183, 4810.494898035726, 4817.325574419584, 4823.324734537167, 4830.637702172351, 4894.8042078317185, 10231.641892533875, 10241.94879025615, 10277.383356998604, 10279.074883260393, 10286.817016043251, 5515.227868098469, 5520.641158324696, 5531.695756733418, 5535.972320138373, 5538.6399884007415, 4435.911281774346, 4888.242322440027, 4992.775325110379, 5011.072951503984, 5015.749212539358, 4157.230912281238, 4174.937375939363, 4176.164767046603, 4194.077302993336, 4226.2181496422645, 1350.6015725361042, 1367.43934986655, 1373.4506197520873, 1381.550995926328, 1389.5275606293908, 851.7827953871847, 941.2940294778916, 1051.9368837869752, 1063.500154927183, 1069.256866477806, 6014.729337179838, 6087.57386982907, 6100.694965251809, 6130.63216207029, 6135.723892424851, 494.053886806761, 494.44868971097685, 498.06364035612813, 506.05367961911463, 507.1631807517625, 4044.3124668805785, 4133.793310334471, 4177.310743727251, 4222.746635201897, 4227.915441691211, 10331.94834025825, 10686.091682206945, 10737.087347575387, 10768.0847127995, 10780.353178809297, 10567.207459440573, 10590.841137382946, 10607.469626518643, 10610.94694526538, 10624.946875265729, 8191.0, 8265.132161122996, 8268.131846156188, 8271.1728827118, 8274.048484424247, 5720.856978575569, 5738.454846789548, 5743.511801496752, 5755.223044888887, 5876.118582212703, 9397.201237894855, 9550.331476796835, 9657.806843862943, 9687.612495500101, 9696.224302055678, 8944.821103578022, 9228.723138305862, 9777.364471309342, 9782.559784809842, 9803.705888823346, 6785.4910881685055, 7126.144862616519, 7297.890531641923, 7403.444741644291, 7491.10106787189, 8097.2307630774985, 8124.106348301801, 8127.715529956423, 8138.145494723206, 8172.468789528662, 7001.439884809305, 7161.892571611535, 7201.13586369618, 7274.672639731119, 7302.123745150403, 7128.786136415916, 7221.31397517235, 7241.710331586888, 7431.182569917197, 7594.734184303523, 6832.760853370109, 6833.2483426824, 6865.141857267841, 6890.896636550356, 6893.138357705287, 4870.488598697228, 5090.211017292326, 5128.7179205144075, 5131.615128865275, 5137.8201762938115, 5322.228276899906, 5353.598480113929, 5394.514493695587, 5417.83746487606, 5452.509274165344], "value": 4563.831793874505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.49005511622335, 337.24457215836526, 346.4015198243321, 351.232556863254, 351.75377235934855, 6183.690815459226, 6211.565190436671, 6229.377062293768, 6241.063840423933, 6254.093156492306, 5835.883282334351, 6007.789727359544, 6087.11736798164, 6091.634501929887, 6122.326544080159, 4680.297955306714, 4692.788824502905, 4727.9834835510355, 4744.881377965561, 4758.119747846659, 4760.857174284777, 4761.738104404257, 4769.5707386335225, 4771.0, 4779.187538118511, 4501.504834468205, 4585.403897493338, 4708.340832283483, 4719.4100737407825, 4728.810847566093, 4694.201985662411, 4699.130660827724, 4712.90574188516, 4713.316569097462, 4718.811247550094, 4126.277901367249, 4147.232761939051, 4150.501939767217, 4150.584941505856, 4151.750894946313, 5982.820515384546, 5985.371535988746, 5987.850303742398, 5991.131285963511, 6001.459868611846, 5480.972595137038, 5492.148716948879, 5497.917531236994, 5498.395176530578, 5506.201600767866, 6363.713632886485, 6474.125992990933, 6497.415232629086, 6515.696860627846, 6535.738570457176, 4597.42532183477, 4603.217453032992, 4608.608268297199, 4610.10103029906, 4618.0763847230355, 6814.182298124208, 6816.909294512904, 6824.556403833784, 6828.795136145874, 6834.350736680008, 4702.694324868872, 4707.388039554904, 4717.103750287434, 4718.41019872516, 4719.95280047202, 4762.214234651313, 4774.045190961821, 4774.641901857374, 4776.379070720854, 4777.713337199779, 5160.174372100446, 5303.787848486095, 5486.725663716798, 5499.010178167968, 5501.614886957875, 6502.219733631994, 6510.381513756186, 6514.902276465857, 6561.835954101186, 6572.474202063823, 1529.9847001529843, 1582.1535478518938, 1594.1152660273428, 1611.7501787223, 1617.6036870966689, 1036.5231993283173, 1044.3942513342242, 1045.9633912813167, 1049.7847941172042, 1052.0741747262514, 6273.686315684289, 6294.433500984842, 6295.433410993032, 6364.681765911779, 6369.649669268235, 6699.464042876558, 6706.0, 6707.53047286695, 6721.1598550181225, 6727.125473688389, 6316.968415157895, 6325.051242313598, 6340.714667839866, 6356.237251529754, 6365.61806291624, 3566.197605538785, 3598.370285200132, 3602.189507360823, 3602.85588576454, 3602.9819850901104, 6815.829604259933, 6919.8962015569805, 6963.1296087989, 6972.930270697329, 6980.581165130108, 6720.798376048726, 6727.0, 6734.966325168441, 6751.594904305757, 6756.966215168893, 6910.689018994158, 6926.376626103674, 6928.792136235921, 6941.0629565009085, 6943.826404339932, 6585.967070164618, 6596.142501474777, 6600.80197594073, 6605.834854128685, 6608.173978252718, 6319.210098737658, 6516.609003459807, 6522.510811689048, 6523.054157147282, 6541.836454088496, 6914.239433662394, 6946.9652651736415, 6952.791416257521, 6953.965230173817, 6968.477364197604, 4495.7976891039325, 4502.054568540643, 4505.932411013903, 4507.6619253555455, 4507.940633950953, 6476.676166191766, 6542.901856472062, 6590.439812615981, 6594.736210551524, 6597.175353080865, 6416.711247993758, 6462.095306657166, 6499.317571655098, 6525.119108920235, 6535.901961470487, 6487.124238227779, 6498.317676643885, 6510.21877374718, 6514.3811337922825, 6521.0, 6409.583377080475, 6436.485081193587, 6480.092787009728, 6483.222013358239, 6497.740090396331, 6452.516061295328, 6619.569727967667, 6624.0395142705, 6635.6350400728425, 6650.634215118215, 6445.806625801233, 6470.514711396759, 6473.676316184266, 6479.254885688018, 6485.124508191522], "value": 4908.14227157729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.208277970369, 867.488181972636, 919.6873063158527, 919.9954000229998, 937.0254934867738, 14877.628059298522, 15319.310631021603, 15364.154971476564, 15368.385264589402, 15368.846311536881, 14230.857691423083, 14261.215633140173, 14301.928490357534, 14303.0, 14324.498642547487, 745.165414735497, 877.2587163846539, 892.1168043636818, 895.154079394972, 903.056306160061, 891.3671293381674, 895.6014573514789, 896.085992287866, 896.4038914122101, 897.5826240798027, 952.4570994533084, 953.3612479638658, 953.718652997364, 953.7663272498247, 954.4607296877277, 782.9256220659029, 943.5423819447562, 944.2304521814699, 957.0094951725001, 957.2150836314225, 698.6052880122714, 700.6951975890453, 704.102269606251, 705.865885481762, 705.9082319298458, 14494.275286235646, 14532.636684082876, 14548.127112373186, 14576.198309092995, 14696.338664760111, 14749.926250368786, 15207.391704331923, 15268.618284542865, 15359.692806143814, 15382.461613843574, 11754.0, 11783.7054073648, 11970.0, 12048.0, 12268.81596776049, 4081.285774989365, 4095.303798354257, 4113.197926404352, 4166.687498437599, 4216.156768646252, 55016.44983550153, 55113.89772204574, 56078.43921560773, 56099.43900560983, 56126.0, 11774.705632359259, 11812.763744725058, 12075.45660445282, 12180.156528138185, 12261.386930653433, 21829.563408732054, 21851.344459666234, 21895.452613684785, 21922.23272185466, 21943.780562194494, 9053.321000924825, 9060.728178154666, 9065.184133428023, 9142.81714365709, 9147.039560846148, 4960.578350840219, 4996.2505624156665, 5045.192769156991, 5058.114829904752, 5070.29015937769, 3565.7860528368383, 3607.2424790793702, 3634.5093412388987, 3639.70882329413, 3640.5995340512522, 628.8207860759661, 638.0684201066402, 720.1897864901986, 733.0397179694511, 742.2169611060383, 710.7476845719798, 811.9512829230265, 819.2708489444399, 820.3683163963715, 840.7982084299724, 9577.952110239543, 9800.852987205197, 10135.189184865194, 10153.644622438327, 10161.288709790391, 628.2680677011322, 724.1129616220088, 742.506233354813, 748.0574476159969, 748.3190296829858, 4618.1918164321105, 4806.206975848946, 4884.902301953941, 4932.654714170046, 5024.346834911438, 59119.0, 59327.70336148378, 59631.70184149052, 59817.700911495165, 59870.0, 53866.0, 54648.45351546434, 55498.445015549325, 56428.0, 56496.43503564994, 50044.49955500398, 50818.237726434134, 51028.23457648138, 53166.73416632892, 53839.730801345744, 9959.601615935282, 10015.449150296803, 10084.647037353658, 10257.17942564608, 10454.68635940923, 37916.62083379131, 38554.80722596369, 38930.0, 38932.41601375925, 39683.0, 47941.76029119832, 49144.75427622982, 49596.50403495919, 50088.74955625198, 50567.74716126396, 11901.464434100313, 12051.0, 12529.122961392615, 12671.429785659851, 12801.61595152147, 13943.302834858014, 13947.0, 14910.77633835515, 14950.92524537414, 15143.697126057197, 13432.798508022583, 13837.377318020512, 13845.376958037114, 14273.357698903366, 14344.856551434352, 13920.58238252854, 14387.064840785315, 14540.85459145395, 14783.926080369529, 15136.924315378352, 13390.26353550564, 13891.305434728425, 13917.930410347883, 14756.188409637143, 15117.622059448602, 11241.55033798639, 11419.37193454368, 11536.36549989725, 11675.766484670428, 11812.468438920097, 11015.669529914116, 11466.885331146581, 11545.480453379787, 12008.099392545419, 12425.875741242471], "value": 7284.646603846933, "unit": "score"}], "name": "dromaeo_css", "value": 7439.800978248959, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 111.0, 111.0, 110.0, 105.0, 110.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 152.0, 171.0, 136.0, 163.0, 149.0, 126.0, 171.0, 126.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 163.0, 164.0, 164.0, 159.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 170.0, 76.0, 76.0, 74.0, 72.0, 158.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 149.0, 92.0, 91.0, 92.0, 157.0, 92.0, 92.0, 145.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 124.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 144.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 55.0, 53.0, 55.0, 56.0, 76.0, 54.0, 53.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 71.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 118.0, 113.0, 117.0, 112.0, 114.0, 114.0, 133.0, 126.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 157.0, 159.0, 158.0, 164.0, 160.0, 157.0, 162.0, 161.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 65.0, 64.0, 78.0, 65.0, 65.0, 64.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1511.1, "alertThreshold": 2.0}]} 03:43:45 INFO - Return code: 0 03:43:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:45 ERROR - # TBPL SUCCESS # 03:43:45 INFO - Running post-action listener: _resource_record_post_action 03:43:45 INFO - Running post-run listener: _resource_record_post_run 03:43:46 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 262144; Write bytes: 495665152; Read time: 12; Write time: 1838240 03:43:46 INFO - install - Wall time: 18s; CPU: 20.0%; Read bytes: 0; Write bytes: 251576320; Read time: 0; Write time: 1185804 03:43:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 244088832; Read time: 12; Write time: 652436 03:43:46 INFO - Running post-run listener: _upload_blobber_files 03:43:46 INFO - Blob upload gear active. 03:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:43:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:47 INFO - (blobuploader) - INFO - Done attempting. 03:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:48 INFO - (blobuploader) - INFO - Done attempting. 03:43:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:48 INFO - Return code: 0 03:43:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19b49c16b635301177dab2f6a973f70faf9fc6e3e5aacc18bcd1dbce6a241204eb87083b603a10bccac7500745e80f27410a1c9b14b4d5c772fb3db70fbb9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3769ed1869573f856b5825e85e360f43465c5e5601114480eff44b561f29e6b80af9ee7ce51e76e62e1d85e71992246a3e31296824c1849a7a19a6998f1fc6a"} 03:43:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:48 INFO - Contents: 03:43:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19b49c16b635301177dab2f6a973f70faf9fc6e3e5aacc18bcd1dbce6a241204eb87083b603a10bccac7500745e80f27410a1c9b14b4d5c772fb3db70fbb9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3769ed1869573f856b5825e85e360f43465c5e5601114480eff44b561f29e6b80af9ee7ce51e76e62e1d85e71992246a3e31296824c1849a7a19a6998f1fc6a"} 03:43:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:48 INFO - Copying logs to upload dir... 03:43:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.567275 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-31 03:43:48.332337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 03:43:48.335938) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19b49c16b635301177dab2f6a973f70faf9fc6e3e5aacc18bcd1dbce6a241204eb87083b603a10bccac7500745e80f27410a1c9b14b4d5c772fb3db70fbb9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3769ed1869573f856b5825e85e360f43465c5e5601114480eff44b561f29e6b80af9ee7ce51e76e62e1d85e71992246a3e31296824c1849a7a19a6998f1fc6a"} build_url:https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/QnrUAGxZRh2WnU4QUpoQmg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19b49c16b635301177dab2f6a973f70faf9fc6e3e5aacc18bcd1dbce6a241204eb87083b603a10bccac7500745e80f27410a1c9b14b4d5c772fb3db70fbb9fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3769ed1869573f856b5825e85e360f43465c5e5601114480eff44b561f29e6b80af9ee7ce51e76e62e1d85e71992246a3e31296824c1849a7a19a6998f1fc6a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 03:43:48.360839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:43:48.361247) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1464690043.976615-2075063295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004764 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 03:43:48.413073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 03:43:48.413524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 03:43:48.413993) ========= ========= Total master_lag: 0.14 =========