builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1465479325.76 results: success (0) buildid: 20160609031728 builduid: f734c0de12fb4e6baa6395c6ad4be62c revision: c41a2fe11dda58f58d158abaffd9f205a6a8e21c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.758846) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.759296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.759703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.778536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.778910) ========= 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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 06:35:26-- 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% 37.9M=0s 2016-06-09 06:35:26 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.917413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.917766) ========= 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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.967308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:25.967685) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c41a2fe11dda58f58d158abaffd9f205a6a8e21c --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-beta --rev c41a2fe11dda58f58d158abaffd9f205a6a8e21c --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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 06:35:26,289 truncating revision to first 12 chars 2016-06-09 06:35:26,289 Setting DEBUG logging. 2016-06-09 06:35:26,289 attempt 1/10 2016-06-09 06:35:26,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c41a2fe11dda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 06:35:26,596 unpacking tar archive at: mozilla-beta-c41a2fe11dda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:26.620461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:26.620833) ========= script_repo_revision: c41a2fe11dda58f58d158abaffd9f205a6a8e21c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:26.621325) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:26.621652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 06:35:26.645789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-09 06:35:26.646105) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:35:27 INFO - MultiFileLogger online at 20160609 06:35:27 in /builds/slave/test 06:35:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:35:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:27 INFO - {'append_to_log': False, 06:35:27 INFO - 'base_work_dir': '/builds/slave/test', 06:35:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:35:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:27 INFO - 'branch': 'Mozilla-Beta', 06:35:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:27 INFO - 'config_files': ('talos/linux_config.py',), 06:35:27 INFO - 'default_actions': ('clobber', 06:35:27 INFO - 'read-buildbot-config', 06:35:27 INFO - 'download-and-extract', 06:35:27 INFO - 'populate-webroot', 06:35:27 INFO - 'create-virtualenv', 06:35:27 INFO - 'install', 06:35:27 INFO - 'run-tests'), 06:35:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:27 INFO - 'download_minidump_stackwalk': True, 06:35:27 INFO - 'download_symbols': 'ondemand', 06:35:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:27 INFO - 'installer_path': 'installer.exe', 06:35:27 INFO - 'log_level': 'info', 06:35:27 INFO - 'log_name': 'talos', 06:35:27 INFO - 'log_to_console': True, 06:35:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:35:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:35:27 INFO - 'opt_config_files': (), 06:35:27 INFO - 'pip_index': False, 06:35:27 INFO - 'sps_profile': False, 06:35:27 INFO - 'sps_profile_interval': 0, 06:35:27 INFO - 'suite': 'dromaeojs', 06:35:27 INFO - 'system_bits': '32', 06:35:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:27 INFO - 'title': 'talos-linux64-ix-021', 06:35:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:27 INFO - 'use_talos_json': True, 06:35:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:27 INFO - 'work_dir': 'build'} 06:35:27 INFO - ##### 06:35:27 INFO - ##### Running clobber step. 06:35:27 INFO - ##### 06:35:27 INFO - Running pre-action listener: _resource_record_pre_action 06:35:27 INFO - Running main action method: clobber 06:35:27 INFO - rmtree: /builds/slave/test/build 06:35:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:28 INFO - Running post-action listener: _resource_record_post_action 06:35:28 INFO - ##### 06:35:28 INFO - ##### Running read-buildbot-config step. 06:35:28 INFO - ##### 06:35:28 INFO - Running pre-action listener: _resource_record_pre_action 06:35:28 INFO - Running main action method: read_buildbot_config 06:35:28 INFO - Using buildbot properties: 06:35:28 INFO - { 06:35:28 INFO - "project": "", 06:35:28 INFO - "product": "firefox", 06:35:28 INFO - "script_repo_revision": "production", 06:35:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:35:28 INFO - "repository": "", 06:35:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:35:28 INFO - "buildid": "20160609031728", 06:35:28 INFO - "pgo_build": "True", 06:35:28 INFO - "basedir": "/builds/slave/test", 06:35:28 INFO - "buildnumber": 39, 06:35:28 INFO - "slavename": "talos-linux64-ix-021", 06:35:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:35:28 INFO - "platform": "ubuntu64_hw", 06:35:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:35:28 INFO - "branch": "mozilla-beta", 06:35:28 INFO - "repo_path": "releases/mozilla-beta", 06:35:28 INFO - "revision": "c41a2fe11dda58f58d158abaffd9f205a6a8e21c", 06:35:28 INFO - "stage_platform": "linux64-pgo", 06:35:28 INFO - "builduid": "f734c0de12fb4e6baa6395c6ad4be62c", 06:35:28 INFO - "slavebuilddir": "test" 06:35:28 INFO - } 06:35:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:35:28 INFO - Running post-action listener: _resource_record_post_action 06:35:28 INFO - ##### 06:35:28 INFO - ##### Running download-and-extract step. 06:35:28 INFO - ##### 06:35:28 INFO - Running pre-action listener: _resource_record_pre_action 06:35:28 INFO - Running main action method: download_and_extract 06:35:28 INFO - mkdir: /builds/slave/test/build/tests 06:35: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')]} 06:35:28 INFO - https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:35:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:35:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:35:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:35:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:35:39 INFO - Downloaded 1327 bytes. 06:35:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:35:39 INFO - Using the following test package requirements: 06:35:39 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:35:39 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:35:39 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:35:39 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'jsshell-linux-x86_64.zip'], 06:35:39 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:35:39 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:35:39 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:35:39 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:35:39 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:35:39 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:35:39 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:35:39 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:35:39 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')]} 06:35:39 INFO - https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:35:49 INFO - Downloaded 24176931 bytes. 06:35:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:35:50 INFO - Return code: 0 06:35:50 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:35:50 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')]} 06:35:50 INFO - https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:35:52 INFO - Downloaded 24176931 bytes. 06:35:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:35:53 INFO - Return code: 0 06:35:53 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')]} 06:35:53 INFO - https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:35:54 INFO - Downloaded 10840145 bytes. 06:35:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:35:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:35:54 INFO - Return code: 0 06:35:54 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')]} 06:35:54 INFO - https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:35:56 INFO - Downloaded 56008157 bytes. 06:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:35:56 INFO - mkdir: /builds/slave/test/properties 06:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:56 INFO - Contents: 06:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:35:56 INFO - Running post-action listener: _resource_record_post_action 06:35:56 INFO - Running post-action listener: set_extra_try_arguments 06:35:56 INFO - ##### 06:35:56 INFO - ##### Running populate-webroot step. 06:35:56 INFO - ##### 06:35:56 INFO - Running pre-action listener: _resource_record_pre_action 06:35:56 INFO - Running main action method: populate_webroot 06:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:56 INFO - '--tppagecycles', 06:35:56 INFO - '7'], 06:35:56 INFO - 'tests': ['tsvgm']}}, 06:35:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['damp', 'tps']}, 06:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'tests': ['damp', 'tps']}, 06:35:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['dromaeo_dom']}, 06:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['a11yr', 06:35:56 INFO - 'ts_paint', 06:35:56 INFO - 'tpaint', 06:35:56 INFO - 'sessionrestore', 06:35:56 INFO - 'sessionrestore_no_auto_restore', 06:35:56 INFO - 'tabpaint']}, 06:35:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['tsvgx', 06:35:56 INFO - 'tsvgr_opacity', 06:35:56 INFO - 'tart', 06:35:56 INFO - 'tscrollx', 06:35:56 INFO - 'cart']}, 06:35:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:56 INFO - 'tsvgr_opacity', 06:35:56 INFO - 'tart', 06:35:56 INFO - 'tscrollx', 06:35:56 INFO - 'cart']}, 06:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'talos_options': ['--disable-e10s'], 06:35:56 INFO - 'tests': ['tp5o']}, 06:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'tests': ['tp5o']}, 06:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'talos_options': ['--disable-e10s', 06:35:56 INFO - '--xperf_path', 06:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:56 INFO - 'tests': ['tp5n']}, 06:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:56 INFO - 'talos_options': ['--xperf_path', 06:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:56 INFO - 'tests': ['tp5n']}}, 06:35:56 INFO - 'talos.zip': {'path': '', 06:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:56 INFO - Running post-action listener: _resource_record_post_action 06:35:56 INFO - ##### 06:35:56 INFO - ##### Running create-virtualenv step. 06:35:56 INFO - ##### 06:35:56 INFO - Running pre-action listener: _resource_record_pre_action 06:35:56 INFO - Running main action method: create_virtualenv 06:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:56 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 06:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:56 INFO - Using real prefix '/usr' 06:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:59 INFO - Installing pip.................done. 06:35:59 INFO - Return code: 0 06:35:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:59 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')]} 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 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')]} 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:35:59 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 06:35:59 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 06:35:59 INFO - Using env: {'DISPLAY': ':0', 06:35:59 INFO - 'HOME': '/home/cltbld', 06:35:59 INFO - 'LANG': 'en_US.UTF-8', 06:35:59 INFO - 'LANGUAGE': 'en_US:en', 06:35:59 INFO - 'LOGNAME': 'cltbld', 06:35:59 INFO - 'MAIL': '/var/mail/cltbld', 06:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:59 INFO - 'MOZ_NO_REMOTE': '1', 06:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:59 INFO - 'NO_EM_RESTART': '1', 06:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:59 INFO - 'PWD': '/builds/slave/test', 06:35:59 INFO - 'SHELL': '/bin/bash', 06:35:59 INFO - 'SHLVL': '1', 06:35:59 INFO - 'TERM': 'linux', 06:35:59 INFO - 'TMOUT': '86400', 06:35:59 INFO - 'USER': 'cltbld', 06:35:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:59 INFO - '_': '/tools/buildbot/bin/python'} 06:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:59 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 06:35:59 INFO - Cleaning up... 06:35:59 INFO - Return code: 0 06:35:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:35:59 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')]} 06:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 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')]} 06:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:59 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:35:59 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 06:35:59 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 06:35:59 INFO - Using env: {'DISPLAY': ':0', 06:35:59 INFO - 'HOME': '/home/cltbld', 06:35:59 INFO - 'LANG': 'en_US.UTF-8', 06:35:59 INFO - 'LANGUAGE': 'en_US:en', 06:35:59 INFO - 'LOGNAME': 'cltbld', 06:35:59 INFO - 'MAIL': '/var/mail/cltbld', 06:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:59 INFO - 'MOZ_NO_REMOTE': '1', 06:35:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:59 INFO - 'NO_EM_RESTART': '1', 06:35:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:59 INFO - 'PWD': '/builds/slave/test', 06:35:59 INFO - 'SHELL': '/bin/bash', 06:35:59 INFO - 'SHLVL': '1', 06:35:59 INFO - 'TERM': 'linux', 06:35:59 INFO - 'TMOUT': '86400', 06:35:59 INFO - 'USER': 'cltbld', 06:35:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:59 INFO - '_': '/tools/buildbot/bin/python'} 06:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:59 INFO - Downloading/unpacking psutil>=0.7.1 06:35:59 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 06:35:59 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 06:35:59 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 06:35:59 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 06:35:59 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 06:35:59 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 06:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:01 INFO - Installing collected packages: psutil 06:36:01 INFO - Running setup.py install for psutil 06:36:01 INFO - building 'psutil._psutil_linux' extension 06:36:01 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 06:36:01 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 06:36:02 INFO - building 'psutil._psutil_posix' extension 06:36:02 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 06:36:02 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 06:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:02 INFO - Successfully installed psutil 06:36:02 INFO - Cleaning up... 06:36:02 INFO - Return code: 0 06:36:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:36:02 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')]} 06:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:02 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')]} 06:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:02 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:02 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 06:36:02 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 06:36:02 INFO - Using env: {'DISPLAY': ':0', 06:36:02 INFO - 'HOME': '/home/cltbld', 06:36:02 INFO - 'LANG': 'en_US.UTF-8', 06:36:02 INFO - 'LANGUAGE': 'en_US:en', 06:36:02 INFO - 'LOGNAME': 'cltbld', 06:36:02 INFO - 'MAIL': '/var/mail/cltbld', 06:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:02 INFO - 'MOZ_NO_REMOTE': '1', 06:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:02 INFO - 'NO_EM_RESTART': '1', 06:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:02 INFO - 'PWD': '/builds/slave/test', 06:36:02 INFO - 'SHELL': '/bin/bash', 06:36:02 INFO - 'SHLVL': '1', 06:36:02 INFO - 'TERM': 'linux', 06:36:02 INFO - 'TMOUT': '86400', 06:36:02 INFO - 'USER': 'cltbld', 06:36:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:02 INFO - '_': '/tools/buildbot/bin/python'} 06:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:02 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 06:36:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:36:04 INFO - Installing collected packages: mozsystemmonitor 06:36:04 INFO - Running setup.py install for mozsystemmonitor 06:36:04 INFO - Successfully installed mozsystemmonitor 06:36:04 INFO - Cleaning up... 06:36:04 INFO - Return code: 0 06:36:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:04 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')]} 06:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:04 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')]} 06:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:04 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:04 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 06:36:04 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 06:36:04 INFO - Using env: {'DISPLAY': ':0', 06:36:04 INFO - 'HOME': '/home/cltbld', 06:36:04 INFO - 'LANG': 'en_US.UTF-8', 06:36:04 INFO - 'LANGUAGE': 'en_US:en', 06:36:04 INFO - 'LOGNAME': 'cltbld', 06:36:04 INFO - 'MAIL': '/var/mail/cltbld', 06:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:04 INFO - 'MOZ_NO_REMOTE': '1', 06:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:04 INFO - 'NO_EM_RESTART': '1', 06:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:04 INFO - 'PWD': '/builds/slave/test', 06:36:04 INFO - 'SHELL': '/bin/bash', 06:36:04 INFO - 'SHLVL': '1', 06:36:04 INFO - 'TERM': 'linux', 06:36:04 INFO - 'TMOUT': '86400', 06:36:04 INFO - 'USER': 'cltbld', 06:36:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:04 INFO - '_': '/tools/buildbot/bin/python'} 06:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:04 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 06:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:06 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 06:36:06 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 06:36:06 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 06:36:06 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 06:36:06 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 06:36:06 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 06:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 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 06:36:07 INFO - Downloading docopt-0.6.1.tar.gz 06:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:07 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:07 INFO - Running setup.py install for blobuploader 06:36:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:07 INFO - Running setup.py install for requests 06:36:07 INFO - Running setup.py install for docopt 06:36:08 INFO - Successfully installed blobuploader requests docopt 06:36:08 INFO - Cleaning up... 06:36:08 INFO - Return code: 0 06:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36: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')]} 06:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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')]} 06:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:08 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:08 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 06:36:08 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 06:36:08 INFO - Using env: {'DISPLAY': ':0', 06:36:08 INFO - 'HOME': '/home/cltbld', 06:36:08 INFO - 'LANG': 'en_US.UTF-8', 06:36:08 INFO - 'LANGUAGE': 'en_US:en', 06:36:08 INFO - 'LOGNAME': 'cltbld', 06:36:08 INFO - 'MAIL': '/var/mail/cltbld', 06:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:08 INFO - 'MOZ_NO_REMOTE': '1', 06:36:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:08 INFO - 'NO_EM_RESTART': '1', 06:36:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:08 INFO - 'PWD': '/builds/slave/test', 06:36:08 INFO - 'SHELL': '/bin/bash', 06:36:08 INFO - 'SHLVL': '1', 06:36:08 INFO - 'TERM': 'linux', 06:36:08 INFO - 'TMOUT': '86400', 06:36:08 INFO - 'USER': 'cltbld', 06:36:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:08 INFO - '_': '/tools/buildbot/bin/python'} 06:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:08 INFO - Running setup.py (path:/tmp/pip-DzSRjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:08 INFO - Running setup.py (path:/tmp/pip-bk8tZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:08 INFO - Running setup.py (path:/tmp/pip-Iz03Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:08 INFO - Running setup.py (path:/tmp/pip-2LZ_ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:08 INFO - Running setup.py (path:/tmp/pip-sSHLSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:08 INFO - Running setup.py (path:/tmp/pip-ODxKgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:08 INFO - Running setup.py (path:/tmp/pip-kdngf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:08 INFO - Running setup.py (path:/tmp/pip-YeVCoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:08 INFO - Running setup.py (path:/tmp/pip-0LBUNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:08 INFO - Running setup.py (path:/tmp/pip-1YmLTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:09 INFO - Running setup.py (path:/tmp/pip-oLiqat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:09 INFO - Running setup.py (path:/tmp/pip-Y5byuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:09 INFO - Running setup.py (path:/tmp/pip-Jacy0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:09 INFO - Running setup.py (path:/tmp/pip-vxpjNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:09 INFO - Running setup.py (path:/tmp/pip-1HGTiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:09 INFO - Running setup.py (path:/tmp/pip-q0_Ns9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:09 INFO - Running setup.py (path:/tmp/pip-v7IKP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:09 INFO - Running setup.py install for manifestparser 06:36:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:09 INFO - Running setup.py install for mozcrash 06:36:09 INFO - Running setup.py install for mozdebug 06:36:09 INFO - Running setup.py install for mozdevice 06:36:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:09 INFO - Running setup.py install for mozfile 06:36:10 INFO - Running setup.py install for mozhttpd 06:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozinfo 06:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozInstall 06:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozleak 06:36:10 INFO - Running setup.py install for mozlog 06:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for moznetwork 06:36:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozprocess 06:36:10 INFO - Running setup.py install for mozprofile 06:36:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozrunner 06:36:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:10 INFO - Running setup.py install for mozscreenshot 06:36:11 INFO - Running setup.py install for moztest 06:36:11 INFO - Running setup.py install for mozversion 06:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:11 INFO - Cleaning up... 06:36:11 INFO - Return code: 0 06:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:11 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')]} 06:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:11 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')]} 06:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:11 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:11 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 06:36:11 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 06:36:11 INFO - Using env: {'DISPLAY': ':0', 06:36:11 INFO - 'HOME': '/home/cltbld', 06:36:11 INFO - 'LANG': 'en_US.UTF-8', 06:36:11 INFO - 'LANGUAGE': 'en_US:en', 06:36:11 INFO - 'LOGNAME': 'cltbld', 06:36:11 INFO - 'MAIL': '/var/mail/cltbld', 06:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:11 INFO - 'MOZ_NO_REMOTE': '1', 06:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:11 INFO - 'NO_EM_RESTART': '1', 06:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:11 INFO - 'PWD': '/builds/slave/test', 06:36:11 INFO - 'SHELL': '/bin/bash', 06:36:11 INFO - 'SHLVL': '1', 06:36:11 INFO - 'TERM': 'linux', 06:36:11 INFO - 'TMOUT': '86400', 06:36:11 INFO - 'USER': 'cltbld', 06:36:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:11 INFO - '_': '/tools/buildbot/bin/python'} 06:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:11 INFO - Running setup.py (path:/tmp/pip-lpnPZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:11 INFO - Running setup.py (path:/tmp/pip-njNxxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:11 INFO - Running setup.py (path:/tmp/pip-XvXam3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:11 INFO - Running setup.py (path:/tmp/pip-TMnmfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:11 INFO - Running setup.py (path:/tmp/pip-T1F_pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:11 INFO - Running setup.py (path:/tmp/pip-nGX2x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:11 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)) 06:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:11 INFO - Running setup.py (path:/tmp/pip-8eJyt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:12 INFO - Running setup.py (path:/tmp/pip-RmdxaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:12 INFO - Running setup.py (path:/tmp/pip-jEezDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:12 INFO - Running setup.py (path:/tmp/pip-c14wSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:12 INFO - Running setup.py (path:/tmp/pip-6l0bGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:12 INFO - Running setup.py (path:/tmp/pip-5Mawk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:12 INFO - Running setup.py (path:/tmp/pip-IqoBJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:12 INFO - Running setup.py (path:/tmp/pip-fuERL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:12 INFO - Running setup.py (path:/tmp/pip-EYKMaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:12 INFO - Running setup.py (path:/tmp/pip-5CPJMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:12 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)) 06:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:12 INFO - Running setup.py (path:/tmp/pip-3ZOXgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:12 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)) 06:36:12 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)) 06:36:12 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)) 06:36:12 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)) 06:36:12 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)) 06:36:12 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)) 06:36:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:12 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 06:36:12 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 06:36:12 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 06:36:12 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 06:36:12 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 06:36:12 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 06:36:14 INFO - Downloading blessings-1.6.tar.gz 06:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:14 INFO - Installing collected packages: blessings 06:36:14 INFO - Running setup.py install for blessings 06:36:14 INFO - Successfully installed blessings 06:36:14 INFO - Cleaning up... 06:36:14 INFO - Return code: 0 06:36:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:15 INFO - Reading from file tmpfile_stdout 06:36:15 INFO - Current package versions: 06:36:15 INFO - argparse == 1.2.1 06:36:15 INFO - blessings == 1.6 06:36:15 INFO - blobuploader == 1.2.4 06:36:15 INFO - docopt == 0.6.1 06:36:15 INFO - manifestparser == 1.1 06:36:15 INFO - mozInstall == 1.12 06:36:15 INFO - mozcrash == 0.17 06:36:15 INFO - mozdebug == 0.1 06:36:15 INFO - mozdevice == 0.48 06:36:15 INFO - mozfile == 1.2 06:36:15 INFO - mozhttpd == 0.7 06:36:15 INFO - mozinfo == 0.9 06:36:15 INFO - mozleak == 0.1 06:36:15 INFO - mozlog == 3.1 06:36:15 INFO - moznetwork == 0.27 06:36:15 INFO - mozprocess == 0.22 06:36:15 INFO - mozprofile == 0.28 06:36:15 INFO - mozrunner == 6.11 06:36:15 INFO - mozscreenshot == 0.1 06:36:15 INFO - mozsystemmonitor == 0.0 06:36:15 INFO - moztest == 0.7 06:36:15 INFO - mozversion == 1.4 06:36:15 INFO - psutil == 3.1.1 06:36:15 INFO - requests == 1.2.3 06:36:15 INFO - wsgiref == 0.1.2 06:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:15 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')]} 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:15 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')]} 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:15 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:15 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 06:36:15 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 06:36:15 INFO - Using env: {'DISPLAY': ':0', 06:36:15 INFO - 'HOME': '/home/cltbld', 06:36:15 INFO - 'LANG': 'en_US.UTF-8', 06:36:15 INFO - 'LANGUAGE': 'en_US:en', 06:36:15 INFO - 'LOGNAME': 'cltbld', 06:36:15 INFO - 'MAIL': '/var/mail/cltbld', 06:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:15 INFO - 'MOZ_NO_REMOTE': '1', 06:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:15 INFO - 'NO_EM_RESTART': '1', 06:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:15 INFO - 'PWD': '/builds/slave/test', 06:36:15 INFO - 'SHELL': '/bin/bash', 06:36:15 INFO - 'SHLVL': '1', 06:36:15 INFO - 'TERM': 'linux', 06:36:15 INFO - 'TMOUT': '86400', 06:36:15 INFO - 'USER': 'cltbld', 06:36:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:15 INFO - '_': '/tools/buildbot/bin/python'} 06:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 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)) 06:36:15 INFO - Cleaning up... 06:36:15 INFO - Return code: 0 06:36:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:15 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')]} 06:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:15 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')]} 06:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:15 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:15 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 06:36:15 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 06:36:15 INFO - Using env: {'DISPLAY': ':0', 06:36:15 INFO - 'HOME': '/home/cltbld', 06:36:15 INFO - 'LANG': 'en_US.UTF-8', 06:36:15 INFO - 'LANGUAGE': 'en_US:en', 06:36:15 INFO - 'LOGNAME': 'cltbld', 06:36:15 INFO - 'MAIL': '/var/mail/cltbld', 06:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:15 INFO - 'MOZ_NO_REMOTE': '1', 06:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:15 INFO - 'NO_EM_RESTART': '1', 06:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:15 INFO - 'PWD': '/builds/slave/test', 06:36:15 INFO - 'SHELL': '/bin/bash', 06:36:15 INFO - 'SHLVL': '1', 06:36:15 INFO - 'TERM': 'linux', 06:36:15 INFO - 'TMOUT': '86400', 06:36:15 INFO - 'USER': 'cltbld', 06:36:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:15 INFO - '_': '/tools/buildbot/bin/python'} 06:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:15 INFO - Downloading/unpacking jsonschema 06:36:15 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 06:36:15 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 06:36:15 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 06:36:15 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 06:36:15 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 06:36:15 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 06:36:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:17 INFO - Downloading/unpacking functools32 (from jsonschema) 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:17 INFO - warning: no files found matching '*.txt' 06:36:17 INFO - no previously-included directories found matching 'build' 06:36:17 INFO - no previously-included directories found matching 'dist' 06:36:17 INFO - no previously-included directories found matching '.git*' 06:36:17 INFO - Installing collected packages: jsonschema, functools32 06:36:17 INFO - Running setup.py install for functools32 06:36:17 INFO - warning: no files found matching '*.txt' 06:36:17 INFO - no previously-included directories found matching 'build' 06:36:17 INFO - no previously-included directories found matching 'dist' 06:36:17 INFO - no previously-included directories found matching '.git*' 06:36:17 INFO - Successfully installed jsonschema functools32 06:36:17 INFO - Cleaning up... 06:36:17 INFO - Return code: 0 06:36:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:36:17 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')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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 0x7f1678b59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cda5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, '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': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', '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 06:36:17 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 06:36:17 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 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:18 INFO - Downloading/unpacking flake8 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:36:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 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 06:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:20 INFO - no previously-included directories found matching 'docs/_build' 06:36:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:36:20 INFO - Running setup.py install for pep8 06:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:36:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:36:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:36:20 INFO - no previously-included directories found matching 'docs/_build' 06:36:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:36:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:36:20 INFO - Cleaning up... 06:36:20 INFO - Return code: 0 06:36:20 INFO - Running post-action listener: _resource_record_post_action 06:36:20 INFO - Running post-action listener: _start_resource_monitoring 06:36:21 INFO - Starting resource monitoring. 06:36:21 INFO - ##### 06:36:21 INFO - ##### Running install step. 06:36:21 INFO - ##### 06:36:21 INFO - Running pre-action listener: _resource_record_pre_action 06:36:21 INFO - Running main action method: install 06:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:21 INFO - Reading from file tmpfile_stdout 06:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:21 INFO - Reading from file tmpfile_stdout 06:36:21 INFO - Output received: 06:36:21 INFO - Usage: mozinstall [options] installer 06:36:21 INFO - Options: 06:36:21 INFO - -h, --help show this help message and exit 06:36:21 INFO - -d DEST, --destination=DEST 06:36:21 INFO - Directory to install application into. [default: 06:36:21 INFO - "/builds/slave/test"] 06:36:21 INFO - --app=APP Application being installed. [default: firefox] 06:36:21 INFO - mkdir: /builds/slave/test/build/application 06:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:36:34 INFO - Reading from file tmpfile_stdout 06:36:34 INFO - Output received: 06:36:34 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:34 INFO - Running post-action listener: _resource_record_post_action 06:36:34 INFO - ##### 06:36:34 INFO - ##### Running run-tests step. 06:36:34 INFO - ##### 06:36:34 INFO - Running pre-action listener: _resource_record_pre_action 06:36:34 INFO - Running main action method: run_tests 06:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:34 INFO - Python 2.7.3 06:36:34 INFO - Return code: 0 06:36:34 INFO - grabbing minidump binary from tooltool 06:36:34 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')]} 06:36:34 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 0x1d69410>, '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 0x1d6a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:34 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 06:36:34 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 06:36:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:34 INFO - Return code: 0 06:36:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:36:35 INFO - Return code: 0 06:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 06:36:35 INFO - Using env: {'DISPLAY': ':0', 06:36:35 INFO - 'HOME': '/home/cltbld', 06:36:35 INFO - 'LANG': 'en_US.UTF-8', 06:36:35 INFO - 'LANGUAGE': 'en_US:en', 06:36:35 INFO - 'LOGNAME': 'cltbld', 06:36:35 INFO - 'MAIL': '/var/mail/cltbld', 06:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:35 INFO - 'MOZ_NO_REMOTE': '1', 06:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:35 INFO - 'NO_EM_RESTART': '1', 06:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:35 INFO - 'PWD': '/builds/slave/test', 06:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:35 INFO - 'SHELL': '/bin/bash', 06:36:35 INFO - 'SHLVL': '1', 06:36:35 INFO - 'TERM': 'linux', 06:36:35 INFO - 'TMOUT': '86400', 06:36:35 INFO - 'USER': 'cltbld', 06:36:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052', 06:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:35 INFO - '_': '/tools/buildbot/bin/python'} 06:36:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 06:36:35 INFO - mozversion application_buildid: 20160609031728 06:36:35 INFO - mozversion application_changeset: c41a2fe11dda58f58d158abaffd9f205a6a8e21c 06:36:35 INFO - mozversion application_display_name: Firefox 06:36:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:35 INFO - mozversion application_name: Firefox 06:36:35 INFO - mozversion application_remotingname: firefox 06:36:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:36:35 INFO - mozversion application_vendor: Mozilla 06:36:35 INFO - mozversion application_version: 48.0 06:36:35 INFO - mozversion platform_buildid: 20160609031728 06:36:35 INFO - mozversion platform_changeset: c41a2fe11dda58f58d158abaffd9f205a6a8e21c 06:36:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:36:35 INFO - mozversion platform_version: 48.0 06:36:35 INFO - using testdate: 1465479395 06:36:35 INFO - actual date: 1465479395 06:36:35 INFO - starting webserver on 'localhost:38855' 06:36:35 INFO - SUITE-START | Running 2 tests 06:36:35 INFO - TEST-START | dromaeo_css 06:36:35 INFO - operating with platform_type : linux_ 06:36:35 INFO - Initialising browser for dromaeo_css test... 06:36:35 INFO - TEST-INFO | started process 18794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRIj5Cd/profile http://localhost:38855/getInfo.html) 06:36:40 INFO - PROCESS | 18794 | __metrics Screen width/height:1600/1200 06:36:40 INFO - PROCESS | 18794 | colorDepth:24 06:36:40 INFO - PROCESS | 18794 | Browser inner width/height: 1024/697 06:36:40 INFO - PROCESS | 18794 | __metrics 06:36:41 ERROR - PROCESS | 18794 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:36:42 INFO - TEST-INFO | 18794: exit 0 06:36:42 INFO - Browser initialized. 06:36:42 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:42 INFO - TEST-INFO | started process 18887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRIj5Cd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:54 INFO - PROCESS | 18887 | RSS: Main: 141262848 06:36:54 INFO - PROCESS | 18887 | 06:37:45 INFO - PROCESS | 18887 | 1465479465270 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] 06:39:53 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38855/tests/dromaeo/cssquery-ext.html) 06:39:54 INFO - PROCESS | 18887 | RSS: Main: 250413056 06:39:54 INFO - PROCESS | 18887 | 06:42:56 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-ext.html (next: http://localhost:38855/tests/dromaeo/cssquery-jquery.html) 06:42:56 INFO - PROCESS | 18887 | RSS: Main: 221454336 06:42:56 INFO - PROCESS | 18887 | 06:45:58 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38855/tests/dromaeo/cssquery-mootools.html) 06:45:59 INFO - PROCESS | 18887 | RSS: Main: 218759168 06:45:59 INFO - PROCESS | 18887 | 06:49:00 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38855/tests/dromaeo/cssquery-prototype.html) 06:49:01 INFO - PROCESS | 18887 | RSS: Main: 221732864 06:49:01 INFO - PROCESS | 18887 | 06:52:04 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38855/tests/dromaeo/cssquery-yui.html) 06:52:04 INFO - PROCESS | 18887 | RSS: Main: 210092032 06:52:04 INFO - PROCESS | 18887 | 06:55:06 INFO - PROCESS | 18887 | Cycle 1(1): loaded http://localhost:38855/tests/dromaeo/cssquery-yui.html (next: http://localhost:38855/tests/dromaeo/cssquery-dojo.html) 06:55:07 INFO - PROCESS | 18887 | RSS: Main: 252755968 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | __start_tp_report 06:55:07 INFO - PROCESS | 18887 | _x_x_mozilla_page_load 06:55:07 INFO - PROCESS | 18887 | _x_x_mozilla_page_load_details 06:55:07 INFO - PROCESS | 18887 | |i|pagename|runs| 06:55:07 INFO - PROCESS | 18887 | |0;dojo.html;3356.3119560490104;3373.780704254223;3399.3881101401753;3415.8292085395724;3439.3981053315665;5590.692511911843;5614.859628509289;5619.971900140498;5621.943780562193;5623.156526521018;5594.188842617818;5615.9157612635845;5618.831435056944;5619.044762390393;5635.154726790984;5084.110280700881;5115.9488405115935;5161.045206636765;5211.609129315298;5241.030409374259;5169.043726910515;5215.921761173586;5240.764165612538;5247.134222853225;5247.475252474741;5230.633855630107;5277.1556550951855;5306.442823503535;5332.520073193412;5357.383900851393;5257.36911570612;5294.602904782157;5299.417064122924;5304.681719096828;5337.386200586904;5145.485451454862;5160.071187186305;5190.06578815813;5199.870003249911;5237.188235823453;5544.085225937715;5568.554515638739;5578.972105139448;5583.944160558383;5591.664500130005;6024.819255422344;6026.728797204092;6031.185789918349;6037.09443583466;6045.33501314855;6090.26916769986;6108.5418593605655;6181.567290289681;6182.752689892444;6205.379462053804;5784.334801497839;5798.652080875161;5803.65178089316;5809.6804675742815;5811.622244554091;5903.911441328383;6324.873502529924;6330.968345158245;6343.175387199634;6345.460635845912;6003.6397816131175;6038.910351068195;6044.447981536373;6050.520950453507;6086.543509236825;6019.638821670626;6030.939690603038;6031.24609423822;6044.516438684895;6045.8488537786025;5825.300963884276;5994.790182343684;6005.519558435315;6028.487578555784;6103.969480152659;6066.514678825683;6067.575269731076;6080.14877917092;6082.391760823883;6118.479929205978;4616.192166370872;4616.515265897099;4616.884577885513;4623.768811559408;4624.745638989821;4111.301078816608;4116.361963895601;4127.7936103194725;4142.855000074983;4175.937360939588;5851.970740146272;5863.2670916135485;5875.823725288248;5882.088276317178;5888.735006924699;6188.288346840171;6206.503479721701;6236.688165591702;6237.721267140316;6239.563230573816;5607.41122182165;5672.4611161940375;5720.48515633595;5869.295684517885;5907.793227237026;5248.6325957182635;5251.501107394792;5251.789928402897;5255.001549705544;5264.894702105937;6344.397282258178;6350.7459701611415;6360.650164241011;6366.808995730135;6369.649669268142;5972.910406343822;6093.299270583762;6155.84610384735;6170.598911070766;6173.660448675366;6243.344448832989;6275.466585340115;6275.937240627535;6291.528135389773;6293.433590976834;5978.701064946822;5979.1031345296815;5979.701014949323;5995.160677505066;6012.5791194617705;5817.563682723898;6118.908216376669;6184.257889053342;6186.10301506288;6189;5930.733117009831;5935.436133567304;5937.079752638348;5948.464638182584;5961.254843144607;5788.594798364243;5877.471027607536;5932.406759324033;5940.702964851654;5942.257217847769;5832.183494310885;5879.794207202898;5901.026330655393;5910.143029260819;5939.109133629817;5955.940440595538;5971.7611295547695;5972.13404056418;5973.641581505123;5989.251343582052;5809.651420914759;5843.561732870136;5854.2389489366105;5870.5010074144175;5942 06:55:07 INFO - PROCESS | 18887 | |1;ext.html;648.0861984601712;680.5304340005392;681.3425044831738;720.9279072092795;732.6153769271132;33255.33489330212;33835.83082084589;41237;42209.36685949713;42350.57649423505;44111.55888441115;44489.55510444895;44680.55319446805;44702;44721;7880.054393472791;8875;9055.185033346997;9057.230135438496;10225.693229203098;10527.210459215552;10621.628243011497;10658.733531661732;10676.252662313642;10679.679609611723;10673.679789606285;10750.656167979003;10758.515866785974;10758.892411075907;10767;10603.681889543326;10639.095676867475;10664.626738064131;10677.519511621995;10680.465976701134;10586.206034547362;10718.088962438202;10719.356838589709;11010.724731881766;11026.393548354838;43428.3485747714;43876.341854872204;43883;43907.34138987918;43981;3547.308274886398;3664.9816750916075;3793.791341476218;3916.020994751312;4172.874813755562;34364.48453273203;34438.65561344379;34492.31015379678;34750.82624586886;35969.280614387564;4413.911721765547;4501.954980450187;4526.456825181;4553.908921821579;4572.702774319692;334108;334875;335405;336289;338025;40387.39418908719;41089.1782164355;63541.364586354466;64394;64509.67745161244;38788.22423551513;38846.22307553833;38849.6115038846;38871;38926.80536597355;15880.047197168207;17311.3941012064;17463.126843657767;17464.476065717794;17481.125943703017;15026.849731502763;15363.769543456858;15365.46220882286;15373;15375.077495350315;9320.8601870972;9398.295127865438;9402.38884472507;9406.717798466058;9459.385139966018;3506.6142724300817;3536.3457760314423;3594.532710747586;3608.693261072838;3634.2913131939545;1096.0573906440454;1146.60442147459;1169.1523645357217;1186.3771519952095;1212.2241765270235;33997.490037649455;34289.65710342915;34585.48121778175;34696.65303346985;34950.65049349474;1182.1724792645182;1202.3807739014414;1224.2409705982348;1238.9380530973594;1262.0849883834146;18259;18359.90820045891;18430.447086587155;18431.72352414715;18500.907495462707;460143;460506;463785;466476;466771;63914.6804265985;65002.349976500576;65025;65116.67441662761;65118.34881651123;1493.5892629526968;1532.6091846579052;1539.238077151817;1540.6610545679932;1627.6744651069832;32274.193145171557;35081.122971925906;36096.81951590225;36385.63614363822;36418.08954776152;53473.46526534685;53641.19538206852;54102.72948635231;54134;54294.72852635712;375728;377605;377657;377750;379073;28167.859160704065;32000.839995799874;32579;33139.50290745593;33169.33661326808;44894.551054489035;45804.77097614491;46046.30930535978;46095.76952115218;46170.07659846851;37328.6267137336;37381.25237495181;37939.430908536946;37985.81007094947;38712.80643596764;38022.61977380191;38290.042748930384;40759.388609170295;41319;42829.571704282556;43566.78216608897;44473.33290000588;45371;45625.54374456213;46515;37060.62939370572;37242.25515489729;37350.25299493941;38660;38771;29158.41683166367;29495.062232807777;29565;29628;29768.10695679133 06:55:07 INFO - PROCESS | 18887 | |2;jquery.html;405.5599674353326;428.58213242088965;440.3757079237872;441.7945655270299;452.6650278793692;17303.221355039022;19145.234190632375;19278.13248403822;19765.308214212506;19887.105080271387;20045.498862528446;20470.692939605917;20855.165793368284;20867.478313042182;20871.165153393846;5680.715964201794;5911.615744976584;5936.940630593704;5955.464008239258;5964.552658550604;4256.318988961767;6215.223097112861;6478.514111441637;6503.28463868974;6508.9349106509035;5927.970360148193;6404.9359506405035;6426.550141490097;6439.710213040401;6470.126532918066;6268.153799237113;6268.968655156741;6270.8118756436925;6302.653354065525;6306.022566502176;5570.944290557123;5628.240187574666;5716.1997320375185;5838.2702162229725;5932.9703351483395;23334.299971000728;23766.287011389686;23962.041518339247;24305.270841874597;24333.391665208335;2403.5192961407615;2569.9100531481495;2582.87085645717;2637.1033848491606;2664.440467501827;10258.948705256425;11160.609378671708;12611;12665.620031398981;14667.853321466862;2034.145658823283;2059.6498595238845;2082.4897900014594;2116.248731700255;2139.6255655260265;81552;85039.14960850374;85565.57217213936;86172.56913715454;86324;9998.600055997678;10446.68659940203;11181.664550063511;11353.54585816558;11646.70883227926;15752.76370854438;16060.116693581966;16086.517404477885;16104.919475402548;16223.51329460118;8479.279261262738;8621.353398495137;8665.783355416164;8769.079246679134;8801.07588703177;7757.224277572311;7856.5678887661725;8381.455205411628;8411.158884111539;8619.396642234984;4956.405231372259;5010.599152067826;5116.130257856174;5153.587712982952;5166.793328266827;2002.239149123353;2076.1176499987446;2084.666453367454;2085.8748475091543;2183.6069507488805;1015.4161357219481;1046.785408991155;1065.238354576466;1079.4117206122683;1121.966341009771;17632.823671763374;18822.905885470485;19472.70790938137;19714.60570788605;19734.111964961612;1023.1916785739331;1071.4000159910474;1075.0700643942932;1126.7690123524658;1136.78969390663;10888.277840875071;11135.665930022113;11138.164637652208;11147.38689372076;11187.664370068911;507200;512879;516694;535493;539304;89661.55169224112;91015.09257509069;91394;91741.54129229445;93325.53337233406;1079.9740246765605;1088.357868857378;1100.5212732461405;1122.259308856151;1123.797716411054;16958.236879340213;17053.829461705223;17261.13694315254;17293.65412691764;17307.221175047405;38422.61577384302;39429.605703942594;40008;40107.197856042134;41435.96410089772;56877.431225687214;59377.10934335902;59392.406075938685;59566.106508403274;59613.70193149007;8694.217520423192;8955.194032537103;9232.769180770534;9389.38968967015;9419.811603768023;12626;13312.46750129984;13666.86333136656;13738.587842364745;13787.724245514833;11749.118816088656;11815.586454474053;12006.21959572625;12044.51821927113;12078.27530348182;11430.542778288775;11668.416579170838;11794.233374830608;11866.940665296619;11924.224925379822;12165.878341216474;12288.569900053455;12340.876591234331;12423.44094515767;12647.557335493213;8680.652773889226;8879.91120088791;8961.955190224267;9062.682806101755;9064.229540489132;9236.445813251226;11742.882571174521;12097.697557561132;12125.939370303093;12196.268223906594 06:55:07 INFO - PROCESS | 18887 | |3;mootools.html;1393.1362555215767;1566.764985252212;1571.756377761447;1782.2870851659334;1889.0649128681305;7775.222477752222;8338.124496927818;8599.441036332633;8615.43999640023;8629.309655227582;8441.62012709428;8609.741707748763;8631.395802293842;8631.827363452727;8638.913610863889;2426.150847203478;2454.0919859651863;2454.202384225125;2456.9754302457013;2458.8032957363457;2388.534235824015;2426.369144022558;2467.8889449974704;2471.653968444419;2485.0432583455317;2377.2749311459997;2400.051979468109;2418.04487227545;2440.9023639054417;2442.218490083174;2386.1052105460453;2432.0393444589376;2443.4013666651786;2453.0555736041665;2460.8400453970526;2382.0590866607595;2428.2229686500327;2437.475942672334;2442.755724427561;2443.8655873926928;7478.850422991564;7656.885146722803;8809.911900880974;8819.559022048936;8875.467471951704;5240.135377662681;5348.973255133738;5388.5958553108285;5395.325584301962;5395.487428694268;3446.5347178131133;3484.5470088888537;3504.877329293488;3609.169890925076;3626.7279954003557;1144.896959273661;1187.1155988788407;1190.470240742861;1209.8003829368145;1228.4287806170173;11628.76742465146;11697.76604467906;11738.765224695544;12013.87986120145;12089.637310880687;4800.0639875224;4804.543568361;4878.048780487842;4884.3650325458175;4919.532644398776;10355.223358248162;10365.118964887919;10375.377477351383;10382.480875956171;10421.218408619385;5538.169274608841;5543.2793736814765;5551;5551.72241387929;5552.91670624941;4988.027334669777;4999.150144475448;5039.647224694309;5043.949560504421;5055.570276526537;4004.799760011988;4038.919221615551;4044.0698639313123;4150.06623509714;4157.355609880473;1313.9934300328437;1334.212814439466;1354.7425989062046;1359.327133069137;1364.7748121559832;982.7150126463246;992.8212921674024;998.6604554451521;1003.0571263012745;1008.3949630221808;5925.4074592541265;5940.168376427304;5960.5231581474245;6008.128821320884;6134.294556126102;476.6734786671141;485;486.2730218323558;508.8931324421913;511.66230288009734;3455.9827200863833;3928.194720082376;4031.8185681644395;4086.264472394938;4094.4677191965447;10402.791944161074;10465.68602941913;10470.947645261876;10592.15262778976;10640.414777187329;10298.528353195179;10301.484925753683;10434.16526677864;10527.420991845369;10532.31539949916;8109.351251899834;8158.592070396457;8195.590220489072;8200.138985406566;8220.712275070344;5815.767369305349;5820.330661973758;5856.619319744203;5981.401859813984;6004.42957918997;9425.764355890884;9541.045895410682;9650.420974741539;9659.130678238993;9751.56117974707;9663.661771837951;9799.51002449889;9843.950780246052;9914.752131196778;10103.848442273518;7536.5101268417375;7619.466637335333;7643.197464266172;7645.961770191114;7670.578118203553;8082.878756818534;8311.335093192409;8333.583320834055;8342.374321925758;8366.958165209135;7455.105387353552;7579.393648507996;7628.122765881994;7635.770926872203;7714.035745531809;7213.1704853942465;7353.338199562065;7398.149212840593;7441.962790186014;7761.301482866569;6580.7038683260325;6604.570702904296;6644.435223006099;6653.733850646114;6654.83362915931;4922.360093187863;4952.975235123801;5065.772040258271;5086.862269108154;5194.636375453682;5113.64204505681;5138.537531622172;5140.46025167352;5162.09663308927;5227.3465816772905 06:55:07 INFO - PROCESS | 18887 | |4;prototype.html;364.6845478660957;367.43231707012654;369.7079307347195;375.2944464406916;381.1766584178176;6417;6458.418742313191;6464.3212462691445;6486.545941784077;6491.610503369801;6069.302030266521;6232.750689972407;6392.073149393335;6401;6445.645489498076;4896.926546101811;4898.583620392271;4903.289023091649;4913.189323761575;4916.852494425155;4863;4887.315775791392;4905.8773530661665;4909.68087074339;4911.361523002005;4692.882677933062;4755.785989630475;4770.356001939728;4863.19757240055;4884.6078867522765;4844.442889067749;4845.27320901864;4873.195922672755;4885.535874091991;4890.853274401738;4324.848630297956;4328.307470804656;4330.17726631939;4332.588404101605;4336.978315108436;6147.72335244915;6155.476784473325;6158.445739883387;6168.9691551541955;6171.722272497748;5759.5968282220265;5759.90561793258;5760.423957604248;5761.740721667535;5768.567357448166;6634.966825165891;6740.056392105109;6778.898316525256;6788.9660551696925;6796;4789.161896668104;4815.398075240595;4817.156997525454;4823.059503396839;4828.903421931577;7008.159020917472;7039;7046.365827075537;7048.471364647672;7053.788386348367;4923.655344125877;4932.334134891816;4934.358533390637;4938.135826230396;4943.060818444484;4985.8005679772405;4987.077390682735;4988;4988.9501104988485;4994.101061808837;5606.299212598426;5675.318961724537;5702.657840529581;5706.600537962303;5736.483716465538;6770.424513916274;6815.488838337045;6816.182058152955;6816.931830681729;6820.3861652451515;1740.095150521747;1759;1764.5676809181832;1766.5936834528131;1766.726157445598;1101.0971003776826;1161.1987728467332;1187.9821802672966;1189.4766302826729;1195.3246415775059;6553.311902250291;6562.2453417856605;6563.278039415661;6575.276719560845;6583.913654246996;6981.685824137926;6982.755603553953;6988.545744526589;6996.580205187705;7002.719891204295;6558.442532384705;6562.146920900348;6567.8358041048405;6570.967145164243;6603.570767900071;3675.246574452231;3707.073231692077;3760.52993375828;3762.398016317376;3767.6420740029653;7258.3104605062435;7259.419246460376;7289.198188199294;7325.743598974011;7350.448716346188;7165.749198778018;7169.784906452711;7178.38983686382;7189.137303523611;7196.712131514785;7277.672504737406;7313.817154571178;7318.121825380988;7321.524100933422;7345.77962661121;6912.861742765217;7038.260982596754;7048.118985126859;7058.082449281766;7062.71749130029;6949.68726407323;6987.7204911802955;6991.650417479004;6991.685374158277;6996.160460744743;7325.963370183115;7328.523645962995;7330.816729581803;7334.266573342623;7341.74303899361;4768.1417344878255;4826.6621336507515;4828.444728856227;4829.348038014823;4830.492798256132;6894.24163342022;7044;7044.964775176091;7046.2249152594195;7055.435565154673;6822.522423430312;6833.214180369122;6837.453003759588;6844.897326540006;6854.760083397057;6759.831004224737;6772.288909664611;6787.66061696923;6798.93201067983;6813.04617353561;6712.932870671426;6722.327767223239;6723.630200339028;6724.394804467622;6733.158355205599;6668.899966500603;6858.6570671467225;6880.105586273752;6882.655867206519;6882.8623427530165;6435.292117867125;6524.314946930694;6544.607323560602;6556.475481961336;6557.704903279268 06:55:07 INFO - PROCESS | 18887 | |5;yui.html;747.1072068877689;765.8085478630343;780.6096951524238;804.9275565199134;827.7516744976506;13464.326783660814;13483.865161348383;13499.055066145374;13604;13619.38712757927;12776.42506087226;12813.935930320358;12881.355932203376;12920;12928.93535532321;739.7263012685314;875.711015364928;886.8581027035675;888.995555022224;896.2292428511475;890.7372325164092;894.1326912894482;895.852184389575;896.9013408525057;899.1458114790942;915.2403505090792;918.9908100918972;919.7608621758358;921.806420651664;921.9861702074475;767.85794627994;914.5244472874101;918.3571499950028;941.5292353823088;942.9764255893589;686.9828254293683;692.6675195905943;693.1820451866795;693.4209934704528;694.0144994108327;14771.630709232248;14804.111753294837;14824.3329050193;14882.776758348633;14893.851061489355;14515.564533064025;14974.251287435585;15001.774973375408;15062.020968637004;15137.394504219817;11963.94018029913;12029.338386388745;12242.81635775464;12246.510139594406;12272.631821045383;4041.191761647653;4045.575214602454;4062.228176646457;4075.5109386873764;4098.877033688965;57618.42381576172;57710.42289577134;57743.42256577464;58271.417285827025;58382.70808645929;10211.642592509226;10477.31897426665;10581.523831427605;11189.776204476027;11582.536698531965;19639.901800490905;19802.504937376394;19822.306219282545;19848.404547863298;19905.303314383927;8822.470651760786;8900.732978010541;9016.143466370684;9021.278297736166;9133.817323653622;4752.6197904168275;4791.856244312677;4829.1307564638;4859.173940430064;4996.150654388763;3403.081168084603;3452.8100954447245;3462.0306314232057;3464.4630082337276;3468.2716629508086;649.2306616659274;651.3681728723132;658.7299207325069;659.3406593406594;662.9900551491731;645.5577929118568;661.5567569728197;694.1254019934818;709.8260926073145;728.2535401213798;9950.651727189514;10025.949870250748;10046.648367307256;10091.798164036825;10224.28430009907;649.224177108351;739.593223726948;743.9696021010939;752.3905636434506;804.786731516137;4261.488621365456;4357.803898824561;4368.514705000315;4494.9325760113625;4602.562756538124;62718.68640656768;63827.36172638214;65235;65379.67310163419;65453.345466545674;56368.43631563714;56454;58058.4194158053;58071.4192858066;58286;51800.48199518032;51947.70130746686;52182.73908630508;52247.216291755656;52484.47515524796;8058.3553315733425;8198.877016844872;8267;8274.089850116603;8312.958435207785;39388;39544.2091158181;39881.60118398779;39882.80058599688;40601.79699101604;48767.268490971954;51177.74411127921;51423.48576514336;52176;52225.21662174995;10719.785604288027;10874.075703565286;10875;10893.400862952614;10930.344179349264;11163.441827908735;11526.88473115258;11739.941300293443;11939.16425850217;12057.457414416196;12353.135280530276;12548.309842958724;12696.238225706118;12739.808902866649;12876.613701588967;11150.330980141218;11506;11569.363684997406;11786.705332366759;11979.820302695292;12215.389230538616;12284.938575307424;12416.875831241572;12551.246925184518;13361.599152025456;10298.256324731492;10586.947065264625;10633.89366106329;10655.147588193082;10667.519961601902;10589.629362972259;10717.356958582199;10774.46127693628;10880.183986201226;10940.671779846618 06:55:07 INFO - PROCESS | 18887 | __end_tp_report 06:55:07 INFO - PROCESS | 18887 | __start_cc_report 06:55:07 INFO - PROCESS | 18887 | _x_x_mozilla_cycle_collect,803 06:55:07 INFO - PROCESS | 18887 | __end_cc_report 06:55:07 INFO - PROCESS | 18887 | __startTimestamp1465480507226__endTimestamp 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | ------- Summary: start ------- 06:55:07 INFO - PROCESS | 18887 | Number of tests: 6 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#0] dojo.html Cycles:165 Average:5667.52 Median:5882.09 stddev:632.57 (10.8%) stddev-sans-first:607.97 06:55:07 INFO - PROCESS | 18887 | Values: 3356.3 3373.8 3399.4 3415.8 3439.4 5590.7 5614.9 5620.0 5621.9 5623.2 5594.2 5615.9 5618.8 5619.0 5635.2 5084.1 5115.9 5161.0 5211.6 5241.0 5169.0 5215.9 5240.8 5247.1 5247.5 5230.6 5277.2 5306.4 5332.5 5357.4 5257.4 5294.6 5299.4 5304.7 5337.4 5145.5 5160.1 5190.1 5199.9 5237.2 5544.1 5568.6 5579.0 5583.9 5591.7 6024.8 6026.7 6031.2 6037.1 6045.3 6090.3 6108.5 6181.6 6182.8 6205.4 5784.3 5798.7 5803.7 5809.7 5811.6 5903.9 6324.9 6331.0 6343.2 6345.5 6003.6 6038.9 6044.4 6050.5 6086.5 6019.6 6030.9 6031.2 6044.5 6045.8 5825.3 5994.8 6005.5 6028.5 6104.0 6066.5 6067.6 6080.1 6082.4 6118.5 4616.2 4616.5 4616.9 4623.8 4624.7 4111.3 4116.4 4127.8 4142.9 4175.9 5852.0 5863.3 5875.8 5882.1 5888.7 6188.3 6206.5 6236.7 6237.7 6239.6 5607.4 5672.5 5720.5 5869.3 5907.8 5248.6 5251.5 5251.8 5255.0 5264.9 6344.4 6350.7 6360.7 6366.8 6369.6 5972.9 6093.3 6155.8 6170.6 6173.7 6243.3 6275.5 6275.9 6291.5 6293.4 5978.7 5979.1 5979.7 5995.2 6012.6 5817.6 6118.9 6184.3 6186.1 6189.0 5930.7 5935.4 5937.1 5948.5 5961.3 5788.6 5877.5 5932.4 5940.7 5942.3 5832.2 5879.8 5901.0 5910.1 5939.1 5955.9 5971.8 5972.1 5973.6 5989.3 5809.7 5843.6 5854.2 5870.5 5942.0 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#1] ext.html Cycles:180 Average:56042.21 Median:37151.44 stddev:104367.60 (280.9%) stddev-sans-first:104577.51 06:55:07 INFO - PROCESS | 18887 | Values: 648.1 680.5 681.3 720.9 732.6 33255.3 33835.8 41237.0 42209.4 42350.6 44111.6 44489.6 44680.6 44702.0 44721.0 7880.1 8875.0 9055.2 9057.2 10225.7 10527.2 10621.6 10658.7 10676.3 10679.7 10673.7 10750.7 10758.5 10758.9 10767.0 10603.7 10639.1 10664.6 10677.5 10680.5 10586.2 10718.1 10719.4 11010.7 11026.4 43428.3 43876.3 43883.0 43907.3 43981.0 3547.3 3665.0 3793.8 3916.0 4172.9 34364.5 34438.7 34492.3 34750.8 35969.3 4413.9 4502.0 4526.5 4553.9 4572.7 334108.0 334875.0 335405.0 336289.0 338025.0 40387.4 41089.2 63541.4 64394.0 64509.7 38788.2 38846.2 38849.6 38871.0 38926.8 15880.0 17311.4 17463.1 17464.5 17481.1 15026.8 15363.8 15365.5 15373.0 15375.1 9320.9 9398.3 9402.4 9406.7 9459.4 3506.6 3536.3 3594.5 3608.7 3634.3 1096.1 1146.6 1169.2 1186.4 1212.2 33997.5 34289.7 34585.5 34696.7 34950.7 1182.2 1202.4 1224.2 1238.9 1262.1 18259.0 18359.9 18430.4 18431.7 18500.9 460143.0 460506.0 463785.0 466476.0 466771.0 63914.7 65002.3 65025.0 65116.7 65118.3 1493.6 1532.6 1539.2 1540.7 1627.7 32274.2 35081.1 36096.8 36385.6 36418.1 53473.5 53641.2 54102.7 54134.0 54294.7 375728.0 377605.0 377657.0 377750.0 379073.0 28167.9 32000.8 32579.0 33139.5 33169.3 44894.6 45804.8 46046.3 46095.8 46170.1 37328.6 37381.3 37939.4 37985.8 38712.8 38022.6 38290.0 40759.4 41319.0 42829.6 43566.8 44473.3 45371.0 45625.5 46515.0 37060.6 37242.3 37350.3 38660.0 38771.0 29158.4 29495.1 29565.0 29628.0 29768.1 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#2] jquery.html Cycles:180 Average:30261.02 Median:13182.78 stddev:85973.23 (652.2%) stddev-sans-first:86185.18 06:55:07 INFO - PROCESS | 18887 | Values: 405.6 428.6 440.4 441.8 452.7 17303.2 19145.2 19278.1 19765.3 19887.1 20045.5 20470.7 20855.2 20867.5 20871.2 5680.7 5911.6 5936.9 5955.5 5964.6 4256.3 6215.2 6478.5 6503.3 6508.9 5928.0 6404.9 6426.6 6439.7 6470.1 6268.2 6269.0 6270.8 6302.7 6306.0 5570.9 5628.2 5716.2 5838.3 5933.0 23334.3 23766.3 23962.0 24305.3 24333.4 2403.5 2569.9 2582.9 2637.1 2664.4 10258.9 11160.6 12611.0 12665.6 14667.9 2034.1 2059.6 2082.5 2116.2 2139.6 81552.0 85039.1 85565.6 86172.6 86324.0 9998.6 10446.7 11181.7 11353.5 11646.7 15752.8 16060.1 16086.5 16104.9 16223.5 8479.3 8621.4 8665.8 8769.1 8801.1 7757.2 7856.6 8381.5 8411.2 8619.4 4956.4 5010.6 5116.1 5153.6 5166.8 2002.2 2076.1 2084.7 2085.9 2183.6 1015.4 1046.8 1065.2 1079.4 1122.0 17632.8 18822.9 19472.7 19714.6 19734.1 1023.2 1071.4 1075.1 1126.8 1136.8 10888.3 11135.7 11138.2 11147.4 11187.7 507200.0 512879.0 516694.0 535493.0 539304.0 89661.6 91015.1 91394.0 91741.5 93325.5 1080.0 1088.4 1100.5 1122.3 1123.8 16958.2 17053.8 17261.1 17293.7 17307.2 38422.6 39429.6 40008.0 40107.2 41436.0 56877.4 59377.1 59392.4 59566.1 59613.7 8694.2 8955.2 9232.8 9389.4 9419.8 12626.0 13312.5 13666.9 13738.6 13787.7 11749.1 11815.6 12006.2 12044.5 12078.3 11430.5 11668.4 11794.2 11866.9 11924.2 12165.9 12288.6 12340.9 12423.4 12647.6 8680.7 8879.9 8962.0 9062.7 9064.2 9236.4 11742.9 12097.7 12125.9 12196.3 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#3] mootools.html Cycles:180 Average:5720.29 Median:5041.80 stddev:3152.46 (62.5%) stddev-sans-first:3144.53 06:55:07 INFO - PROCESS | 18887 | Values: 1393.1 1566.8 1571.8 1782.3 1889.1 7775.2 8338.1 8599.4 8615.4 8629.3 8441.6 8609.7 8631.4 8631.8 8638.9 2426.2 2454.1 2454.2 2457.0 2458.8 2388.5 2426.4 2467.9 2471.7 2485.0 2377.3 2400.1 2418.0 2440.9 2442.2 2386.1 2432.0 2443.4 2453.1 2460.8 2382.1 2428.2 2437.5 2442.8 2443.9 7478.9 7656.9 8809.9 8819.6 8875.5 5240.1 5349.0 5388.6 5395.3 5395.5 3446.5 3484.5 3504.9 3609.2 3626.7 1144.9 1187.1 1190.5 1209.8 1228.4 11628.8 11697.8 11738.8 12013.9 12089.6 4800.1 4804.5 4878.0 4884.4 4919.5 10355.2 10365.1 10375.4 10382.5 10421.2 5538.2 5543.3 5551.0 5551.7 5552.9 4988.0 4999.2 5039.6 5043.9 5055.6 4004.8 4038.9 4044.1 4150.1 4157.4 1314.0 1334.2 1354.7 1359.3 1364.8 982.7 992.8 998.7 1003.1 1008.4 5925.4 5940.2 5960.5 6008.1 6134.3 476.7 485.0 486.3 508.9 511.7 3456.0 3928.2 4031.8 4086.3 4094.5 10402.8 10465.7 10470.9 10592.2 10640.4 10298.5 10301.5 10434.2 10527.4 10532.3 8109.4 8158.6 8195.6 8200.1 8220.7 5815.8 5820.3 5856.6 5981.4 6004.4 9425.8 9541.0 9650.4 9659.1 9751.6 9663.7 9799.5 9844.0 9914.8 10103.8 7536.5 7619.5 7643.2 7646.0 7670.6 8082.9 8311.3 8333.6 8342.4 8367.0 7455.1 7579.4 7628.1 7635.8 7714.0 7213.2 7353.3 7398.1 7442.0 7761.3 6580.7 6604.6 6644.4 6653.7 6654.8 4922.4 4953.0 5065.8 5086.9 5194.6 5113.6 5138.5 5140.5 5162.1 5227.3 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#4] prototype.html Cycles:180 Average:5703.90 Median:6507.96 stddev:1711.06 (26.3%) stddev-sans-first:1668.27 06:55:07 INFO - PROCESS | 18887 | Values: 364.7 367.4 369.7 375.3 381.2 6417.0 6458.4 6464.3 6486.5 6491.6 6069.3 6232.8 6392.1 6401.0 6445.6 4896.9 4898.6 4903.3 4913.2 4916.9 4863.0 4887.3 4905.9 4909.7 4911.4 4692.9 4755.8 4770.4 4863.2 4884.6 4844.4 4845.3 4873.2 4885.5 4890.9 4324.8 4328.3 4330.2 4332.6 4337.0 6147.7 6155.5 6158.4 6169.0 6171.7 5759.6 5759.9 5760.4 5761.7 5768.6 6635.0 6740.1 6778.9 6789.0 6796.0 4789.2 4815.4 4817.2 4823.1 4828.9 7008.2 7039.0 7046.4 7048.5 7053.8 4923.7 4932.3 4934.4 4938.1 4943.1 4985.8 4987.1 4988.0 4989.0 4994.1 5606.3 5675.3 5702.7 5706.6 5736.5 6770.4 6815.5 6816.2 6816.9 6820.4 1740.1 1759.0 1764.6 1766.6 1766.7 1101.1 1161.2 1188.0 1189.5 1195.3 6553.3 6562.2 6563.3 6575.3 6583.9 6981.7 6982.8 6988.5 6996.6 7002.7 6558.4 6562.1 6567.8 6571.0 6603.6 3675.2 3707.1 3760.5 3762.4 3767.6 7258.3 7259.4 7289.2 7325.7 7350.4 7165.7 7169.8 7178.4 7189.1 7196.7 7277.7 7313.8 7318.1 7321.5 7345.8 6912.9 7038.3 7048.1 7058.1 7062.7 6949.7 6987.7 6991.7 6991.7 6996.2 7326.0 7328.5 7330.8 7334.3 7341.7 4768.1 4826.7 4828.4 4829.3 4830.5 6894.2 7044.0 7045.0 7046.2 7055.4 6822.5 6833.2 6837.5 6844.9 6854.8 6759.8 6772.3 6787.7 6798.9 6813.0 6712.9 6722.3 6723.6 6724.4 6733.2 6668.9 6858.7 6880.1 6882.7 6882.9 6435.3 6524.3 6544.6 6556.5 6557.7 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - PROCESS | 18887 | [#5] yui.html Cycles:180 Average:15385.35 Median:4363.16 stddev:18260.56 (418.5%) stddev-sans-first:18278.70 06:55:07 INFO - PROCESS | 18887 | Values: 747.1 765.8 780.6 804.9 827.8 13464.3 13483.9 13499.1 13604.0 13619.4 12776.4 12813.9 12881.4 12920.0 12928.9 739.7 875.7 886.9 889.0 896.2 890.7 894.1 895.9 896.9 899.1 915.2 919.0 919.8 921.8 922.0 767.9 914.5 918.4 941.5 943.0 687.0 692.7 693.2 693.4 694.0 14771.6 14804.1 14824.3 14882.8 14893.9 14515.6 14974.3 15001.8 15062.0 15137.4 11963.9 12029.3 12242.8 12246.5 12272.6 4041.2 4045.6 4062.2 4075.5 4098.9 57618.4 57710.4 57743.4 58271.4 58382.7 10211.6 10477.3 10581.5 11189.8 11582.5 19639.9 19802.5 19822.3 19848.4 19905.3 8822.5 8900.7 9016.1 9021.3 9133.8 4752.6 4791.9 4829.1 4859.2 4996.2 3403.1 3452.8 3462.0 3464.5 3468.3 649.2 651.4 658.7 659.3 663.0 645.6 661.6 694.1 709.8 728.3 9950.7 10025.9 10046.6 10091.8 10224.3 649.2 739.6 744.0 752.4 804.8 4261.5 4357.8 4368.5 4494.9 4602.6 62718.7 63827.4 65235.0 65379.7 65453.3 56368.4 56454.0 58058.4 58071.4 58286.0 51800.5 51947.7 52182.7 52247.2 52484.5 8058.4 8198.9 8267.0 8274.1 8313.0 39388.0 39544.2 39881.6 39882.8 40601.8 48767.3 51177.7 51423.5 52176.0 52225.2 10719.8 10874.1 10875.0 10893.4 10930.3 11163.4 11526.9 11739.9 11939.2 12057.5 12353.1 12548.3 12696.2 12739.8 12876.6 11150.3 11506.0 11569.4 11786.7 11979.8 12215.4 12284.9 12416.9 12551.2 13361.6 10298.3 10586.9 10633.9 10655.1 10667.5 10589.6 10717.4 10774.5 10880.2 10940.7 06:55:07 INFO - PROCESS | 18887 | -------- Summary: end -------- 06:55:07 INFO - PROCESS | 18887 | 06:55:07 INFO - TEST-INFO | 18887: exit 0 06:55:07 INFO - TEST-OK | dromaeo_css | took 1112205ms 06:55:07 INFO - TEST-START | kraken 06:55:07 INFO - operating with platform_type : linux_ 06:55:07 INFO - Initialising browser for kraken test... 06:55:07 INFO - TEST-INFO | started process 19073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMLC35/profile http://localhost:38855/getInfo.html) 06:55:12 INFO - PROCESS | 19073 | __metrics Screen width/height:1600/1200 06:55:12 INFO - PROCESS | 19073 | colorDepth:24 06:55:12 INFO - PROCESS | 19073 | Browser inner width/height: 1024/697 06:55:12 INFO - PROCESS | 19073 | __metrics 06:55:13 ERROR - PROCESS | 19073 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:55:14 INFO - TEST-INFO | 19073: exit 0 06:55:14 INFO - Browser initialized. 06:55:14 INFO - Running cycle 1/1 for kraken test... 06:55:14 INFO - TEST-INFO | started process 19162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMLC35/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:26 INFO - PROCESS | 19162 | RSS: Main: 140791808 06:55:26 INFO - PROCESS | 19162 | 06:55:28 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38855/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:29 INFO - PROCESS | 19162 | RSS: Main: 197292032 06:55:29 INFO - PROCESS | 19162 | 06:55:32 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38855/tests/kraken/driver.html?testName=audio-dft) 06:55:32 INFO - PROCESS | 19162 | RSS: Main: 184492032 06:55:32 INFO - PROCESS | 19162 | 06:55:35 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38855/tests/kraken/driver.html?testName=audio-fft) 06:55:36 INFO - PROCESS | 19162 | RSS: Main: 273272832 06:55:36 INFO - PROCESS | 19162 | 06:55:38 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38855/tests/kraken/driver.html?testName=audio-oscillator) 06:55:38 INFO - PROCESS | 19162 | RSS: Main: 179068928 06:55:38 INFO - PROCESS | 19162 | 06:55:41 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38855/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:41 INFO - PROCESS | 19162 | RSS: Main: 178012160 06:55:41 INFO - PROCESS | 19162 | 06:55:44 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38855/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:45 INFO - PROCESS | 19162 | RSS: Main: 212295680 06:55:45 INFO - PROCESS | 19162 | 06:55:48 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38855/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:49 INFO - PROCESS | 19162 | RSS: Main: 212611072 06:55:49 INFO - PROCESS | 19162 | 06:55:51 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38855/tests/kraken/driver.html?testName=json-parse-financial) 06:55:52 INFO - PROCESS | 19162 | RSS: Main: 212168704 06:55:52 INFO - PROCESS | 19162 | 06:55:54 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38855/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:54 INFO - PROCESS | 19162 | RSS: Main: 191967232 06:55:54 INFO - PROCESS | 19162 | 06:55:56 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:56 INFO - PROCESS | 19162 | RSS: Main: 196100096 06:55:56 INFO - PROCESS | 19162 | 06:55:58 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:59 INFO - PROCESS | 19162 | RSS: Main: 209723392 06:55:59 INFO - PROCESS | 19162 | 06:56:01 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:02 INFO - PROCESS | 19162 | RSS: Main: 218075136 06:56:02 INFO - PROCESS | 19162 | 06:56:05 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:05 INFO - PROCESS | 19162 | RSS: Main: 215293952 06:56:05 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | Cycle 1(1): loaded http://localhost:38855/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38855/tests/kraken/driver.html?testName=ai-astar) 06:56:07 INFO - PROCESS | 19162 | RSS: Main: 276119552 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | __start_tp_report 06:56:07 INFO - PROCESS | 19162 | _x_x_mozilla_page_load 06:56:07 INFO - PROCESS | 19162 | _x_x_mozilla_page_load_details 06:56:07 INFO - PROCESS | 19162 | |i|pagename|runs| 06:56:07 INFO - PROCESS | 19162 | |0;ai-astar;109;111;111;111;110;110;109;113;111;111 06:56:07 INFO - PROCESS | 19162 | |1;audio-beat-detection;157;127;155;187;128;163;150;128;177;127 06:56:07 INFO - PROCESS | 19162 | |2;audio-dft;162;161;162;170;160;160;160;160;160;160 06:56:07 INFO - PROCESS | 19162 | |3;audio-fft;76;75;75;174;76;77;74;74;161;76 06:56:07 INFO - PROCESS | 19162 | |4;audio-oscillator;93;93;151;91;93;92;154;92;94;150 06:56:07 INFO - PROCESS | 19162 | |5;imaging-gaussian-blur;116;118;116;117;116;116;117;116;116;117 06:56:07 INFO - PROCESS | 19162 | |6;imaging-darkroom;146;146;146;145;147;145;145;145;145;145 06:56:07 INFO - PROCESS | 19162 | |7;imaging-desaturate;94;95;96;94;95;94;95;95;94;95 06:56:07 INFO - PROCESS | 19162 | |8;json-parse-financial;55;53;54;55;54;54;53;76;55;52 06:56:07 INFO - PROCESS | 19162 | |9;json-stringify-tinderbox;58;58;57;58;58;58;58;58;58;58 06:56:07 INFO - PROCESS | 19162 | |10;stanford-crypto-aes;73;72;74;74;74;75;74;74;74;73 06:56:07 INFO - PROCESS | 19162 | |11;stanford-crypto-ccm;116;115;115;114;122;114;114;112;130;137 06:56:07 INFO - PROCESS | 19162 | |12;stanford-crypto-pbkdf2;164;158;156;165;154;162;157;163;161;163 06:56:07 INFO - PROCESS | 19162 | |13;stanford-crypto-sha256-iterative;66;72;67;67;67;67;67;66;69;65 06:56:07 INFO - PROCESS | 19162 | __end_tp_report 06:56:07 INFO - PROCESS | 19162 | __start_cc_report 06:56:07 INFO - PROCESS | 19162 | _x_x_mozilla_cycle_collect,1582 06:56:07 INFO - PROCESS | 19162 | __end_cc_report 06:56:07 INFO - PROCESS | 19162 | __startTimestamp1465480567841__endTimestamp 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | ------- Summary: start ------- 06:56:07 INFO - PROCESS | 19162 | Number of tests: 14 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.17 (1.1%) stddev-sans-first:1.09 06:56:07 INFO - PROCESS | 19162 | Values: 109.0 111.0 111.0 111.0 110.0 110.0 109.0 113.0 111.0 111.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.00 stddev:22.03 (14.1%) stddev-sans-first:23.21 06:56:07 INFO - PROCESS | 19162 | Values: 157.0 127.0 155.0 187.0 128.0 163.0 150.0 128.0 177.0 127.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#2] audio-dft Cycles:10 Average:161.50 Median:160.50 stddev:3.10 (1.9%) stddev-sans-first:3.28 06:56:07 INFO - PROCESS | 19162 | Values: 162.0 161.0 162.0 170.0 160.0 160.0 160.0 160.0 160.0 160.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.50 stddev:38.98 (51.6%) stddev-sans-first:40.80 06:56:07 INFO - PROCESS | 19162 | Values: 76.0 75.0 75.0 174.0 76.0 77.0 74.0 74.0 161.0 76.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:92.50 stddev:28.57 (30.9%) stddev-sans-first:29.61 06:56:07 INFO - PROCESS | 19162 | Values: 93.0 93.0 151.0 91.0 93.0 92.0 154.0 92.0 94.0 150.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 06:56:07 INFO - PROCESS | 19162 | Values: 116.0 118.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:56:07 INFO - PROCESS | 19162 | Values: 146.0 146.0 146.0 145.0 147.0 145.0 145.0 145.0 145.0 145.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:56:07 INFO - PROCESS | 19162 | Values: 94.0 95.0 96.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.50 stddev:7.06 (13.0%) stddev-sans-first:7.48 06:56:07 INFO - PROCESS | 19162 | Values: 55.0 53.0 54.0 55.0 54.0 54.0 53.0 76.0 55.0 52.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 06:56:07 INFO - PROCESS | 19162 | Values: 58.0 58.0 57.0 58.0 58.0 58.0 58.0 58.0 58.0 58.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 06:56:07 INFO - PROCESS | 19162 | Values: 73.0 72.0 74.0 74.0 74.0 75.0 74.0 74.0 74.0 73.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:115.50 stddev:8.29 (7.2%) stddev-sans-first:8.73 06:56:07 INFO - PROCESS | 19162 | Values: 116.0 115.0 115.0 114.0 122.0 114.0 114.0 112.0 130.0 137.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:162.50 stddev:3.77 (2.3%) stddev-sans-first:3.76 06:56:07 INFO - PROCESS | 19162 | Values: 164.0 158.0 156.0 165.0 154.0 162.0 157.0 163.0 161.0 163.0 06:56:07 INFO - PROCESS | 19162 | 06:56:07 INFO - PROCESS | 19162 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.95 (2.9%) stddev-sans-first:2.01 06:56:07 INFO - PROCESS | 19162 | Values: 66.0 72.0 67.0 67.0 67.0 67.0 67.0 66.0 69.0 65.0 06:56:07 INFO - PROCESS | 19162 | -------- Summary: end -------- 06:56:07 INFO - PROCESS | 19162 | 06:56:08 INFO - TEST-INFO | 19162: exit 0 06:56:08 INFO - TEST-OK | kraken | took 60910ms 06:56:08 INFO - SUITE-END | took 1173s 06:56:08 INFO - Completed test suite (00:19:33) 06:56:08 INFO - javascript benchmark 06:56:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.3119560490104, 3373.780704254223, 3399.3881101401753, 3415.8292085395724, 3439.3981053315665, 5590.692511911843, 5614.859628509289, 5619.971900140498, 5621.943780562193, 5623.156526521018, 5594.188842617818, 5615.9157612635845, 5618.831435056944, 5619.044762390393, 5635.154726790984, 5084.110280700881, 5115.9488405115935, 5161.045206636765, 5211.609129315298, 5241.030409374259, 5169.043726910515, 5215.921761173586, 5240.764165612538, 5247.134222853225, 5247.475252474741, 5230.633855630107, 5277.1556550951855, 5306.442823503535, 5332.520073193412, 5357.383900851393, 5257.36911570612, 5294.602904782157, 5299.417064122924, 5304.681719096828, 5337.386200586904, 5145.485451454862, 5160.071187186305, 5190.06578815813, 5199.870003249911, 5237.188235823453, 5544.085225937715, 5568.554515638739, 5578.972105139448, 5583.944160558383, 5591.664500130005, 6024.819255422344, 6026.728797204092, 6031.185789918349, 6037.09443583466, 6045.33501314855, 6090.26916769986, 6108.5418593605655, 6181.567290289681, 6182.752689892444, 6205.379462053804, 5784.334801497839, 5798.652080875161, 5803.65178089316, 5809.6804675742815, 5811.622244554091, 5903.911441328383, 6324.873502529924, 6330.968345158245, 6343.175387199634, 6345.460635845912, 6003.6397816131175, 6038.910351068195, 6044.447981536373, 6050.520950453507, 6086.543509236825, 6019.638821670626, 6030.939690603038, 6031.24609423822, 6044.516438684895, 6045.8488537786025, 5825.300963884276, 5994.790182343684, 6005.519558435315, 6028.487578555784, 6103.969480152659, 6066.514678825683, 6067.575269731076, 6080.14877917092, 6082.391760823883, 6118.479929205978, 4616.192166370872, 4616.515265897099, 4616.884577885513, 4623.768811559408, 4624.745638989821, 4111.301078816608, 4116.361963895601, 4127.7936103194725, 4142.855000074983, 4175.937360939588, 5851.970740146272, 5863.2670916135485, 5875.823725288248, 5882.088276317178, 5888.735006924699, 6188.288346840171, 6206.503479721701, 6236.688165591702, 6237.721267140316, 6239.563230573816, 5607.41122182165, 5672.4611161940375, 5720.48515633595, 5869.295684517885, 5907.793227237026, 5248.6325957182635, 5251.501107394792, 5251.789928402897, 5255.001549705544, 5264.894702105937, 6344.397282258178, 6350.7459701611415, 6360.650164241011, 6366.808995730135, 6369.649669268142, 5972.910406343822, 6093.299270583762, 6155.84610384735, 6170.598911070766, 6173.660448675366, 6243.344448832989, 6275.466585340115, 6275.937240627535, 6291.528135389773, 6293.433590976834, 5978.701064946822, 5979.1031345296815, 5979.701014949323, 5995.160677505066, 6012.5791194617705, 5817.563682723898, 6118.908216376669, 6184.257889053342, 6186.10301506288, 6189.0, 5930.733117009831, 5935.436133567304, 5937.079752638348, 5948.464638182584, 5961.254843144607, 5788.594798364243, 5877.471027607536, 5932.406759324033, 5940.702964851654, 5942.257217847769, 5832.183494310885, 5879.794207202898, 5901.026330655393, 5910.143029260819, 5939.109133629817, 5955.940440595538, 5971.7611295547695, 5972.13404056418, 5973.641581505123, 5989.251343582052, 5809.651420914759, 5843.561732870136, 5854.2389489366105, 5870.5010074144175, 5942.0], "value": 5625.988426620121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.0861984601712, 680.5304340005392, 681.3425044831738, 720.9279072092795, 732.6153769271132, 33255.33489330212, 33835.83082084589, 41237.0, 42209.36685949713, 42350.57649423505, 44111.55888441115, 44489.55510444895, 44680.55319446805, 44702.0, 44721.0, 7880.054393472791, 8875.0, 9055.185033346997, 9057.230135438496, 10225.693229203098, 10527.210459215552, 10621.628243011497, 10658.733531661732, 10676.252662313642, 10679.679609611723, 10673.679789606285, 10750.656167979003, 10758.515866785974, 10758.892411075907, 10767.0, 10603.681889543326, 10639.095676867475, 10664.626738064131, 10677.519511621995, 10680.465976701134, 10586.206034547362, 10718.088962438202, 10719.356838589709, 11010.724731881766, 11026.393548354838, 43428.3485747714, 43876.341854872204, 43883.0, 43907.34138987918, 43981.0, 3547.308274886398, 3664.9816750916075, 3793.791341476218, 3916.020994751312, 4172.874813755562, 34364.48453273203, 34438.65561344379, 34492.31015379678, 34750.82624586886, 35969.280614387564, 4413.911721765547, 4501.954980450187, 4526.456825181, 4553.908921821579, 4572.702774319692, 334108.0, 334875.0, 335405.0, 336289.0, 338025.0, 40387.39418908719, 41089.1782164355, 63541.364586354466, 64394.0, 64509.67745161244, 38788.22423551513, 38846.22307553833, 38849.6115038846, 38871.0, 38926.80536597355, 15880.047197168207, 17311.3941012064, 17463.126843657767, 17464.476065717794, 17481.125943703017, 15026.849731502763, 15363.769543456858, 15365.46220882286, 15373.0, 15375.077495350315, 9320.8601870972, 9398.295127865438, 9402.38884472507, 9406.717798466058, 9459.385139966018, 3506.6142724300817, 3536.3457760314423, 3594.532710747586, 3608.693261072838, 3634.2913131939545, 1096.0573906440454, 1146.60442147459, 1169.1523645357217, 1186.3771519952095, 1212.2241765270235, 33997.490037649455, 34289.65710342915, 34585.48121778175, 34696.65303346985, 34950.65049349474, 1182.1724792645182, 1202.3807739014414, 1224.2409705982348, 1238.9380530973594, 1262.0849883834146, 18259.0, 18359.90820045891, 18430.447086587155, 18431.72352414715, 18500.907495462707, 460143.0, 460506.0, 463785.0, 466476.0, 466771.0, 63914.6804265985, 65002.349976500576, 65025.0, 65116.67441662761, 65118.34881651123, 1493.5892629526968, 1532.6091846579052, 1539.238077151817, 1540.6610545679932, 1627.6744651069832, 32274.193145171557, 35081.122971925906, 36096.81951590225, 36385.63614363822, 36418.08954776152, 53473.46526534685, 53641.19538206852, 54102.72948635231, 54134.0, 54294.72852635712, 375728.0, 377605.0, 377657.0, 377750.0, 379073.0, 28167.859160704065, 32000.839995799874, 32579.0, 33139.50290745593, 33169.33661326808, 44894.551054489035, 45804.77097614491, 46046.30930535978, 46095.76952115218, 46170.07659846851, 37328.6267137336, 37381.25237495181, 37939.430908536946, 37985.81007094947, 38712.80643596764, 38022.61977380191, 38290.042748930384, 40759.388609170295, 41319.0, 42829.571704282556, 43566.78216608897, 44473.33290000588, 45371.0, 45625.54374456213, 46515.0, 37060.62939370572, 37242.25515489729, 37350.25299493941, 38660.0, 38771.0, 29158.41683166367, 29495.062232807777, 29565.0, 29628.0, 29768.10695679133], "value": 20076.640538628926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.5599674353326, 428.58213242088965, 440.3757079237872, 441.7945655270299, 452.6650278793692, 17303.221355039022, 19145.234190632375, 19278.13248403822, 19765.308214212506, 19887.105080271387, 20045.498862528446, 20470.692939605917, 20855.165793368284, 20867.478313042182, 20871.165153393846, 5680.715964201794, 5911.615744976584, 5936.940630593704, 5955.464008239258, 5964.552658550604, 4256.318988961767, 6215.223097112861, 6478.514111441637, 6503.28463868974, 6508.9349106509035, 5927.970360148193, 6404.9359506405035, 6426.550141490097, 6439.710213040401, 6470.126532918066, 6268.153799237113, 6268.968655156741, 6270.8118756436925, 6302.653354065525, 6306.022566502176, 5570.944290557123, 5628.240187574666, 5716.1997320375185, 5838.2702162229725, 5932.9703351483395, 23334.299971000728, 23766.287011389686, 23962.041518339247, 24305.270841874597, 24333.391665208335, 2403.5192961407615, 2569.9100531481495, 2582.87085645717, 2637.1033848491606, 2664.440467501827, 10258.948705256425, 11160.609378671708, 12611.0, 12665.620031398981, 14667.853321466862, 2034.145658823283, 2059.6498595238845, 2082.4897900014594, 2116.248731700255, 2139.6255655260265, 81552.0, 85039.14960850374, 85565.57217213936, 86172.56913715454, 86324.0, 9998.600055997678, 10446.68659940203, 11181.664550063511, 11353.54585816558, 11646.70883227926, 15752.76370854438, 16060.116693581966, 16086.517404477885, 16104.919475402548, 16223.51329460118, 8479.279261262738, 8621.353398495137, 8665.783355416164, 8769.079246679134, 8801.07588703177, 7757.224277572311, 7856.5678887661725, 8381.455205411628, 8411.158884111539, 8619.396642234984, 4956.405231372259, 5010.599152067826, 5116.130257856174, 5153.587712982952, 5166.793328266827, 2002.239149123353, 2076.1176499987446, 2084.666453367454, 2085.8748475091543, 2183.6069507488805, 1015.4161357219481, 1046.785408991155, 1065.238354576466, 1079.4117206122683, 1121.966341009771, 17632.823671763374, 18822.905885470485, 19472.70790938137, 19714.60570788605, 19734.111964961612, 1023.1916785739331, 1071.4000159910474, 1075.0700643942932, 1126.7690123524658, 1136.78969390663, 10888.277840875071, 11135.665930022113, 11138.164637652208, 11147.38689372076, 11187.664370068911, 507200.0, 512879.0, 516694.0, 535493.0, 539304.0, 89661.55169224112, 91015.09257509069, 91394.0, 91741.54129229445, 93325.53337233406, 1079.9740246765605, 1088.357868857378, 1100.5212732461405, 1122.259308856151, 1123.797716411054, 16958.236879340213, 17053.829461705223, 17261.13694315254, 17293.65412691764, 17307.221175047405, 38422.61577384302, 39429.605703942594, 40008.0, 40107.197856042134, 41435.96410089772, 56877.431225687214, 59377.10934335902, 59392.406075938685, 59566.106508403274, 59613.70193149007, 8694.217520423192, 8955.194032537103, 9232.769180770534, 9389.38968967015, 9419.811603768023, 12626.0, 13312.46750129984, 13666.86333136656, 13738.587842364745, 13787.724245514833, 11749.118816088656, 11815.586454474053, 12006.21959572625, 12044.51821927113, 12078.27530348182, 11430.542778288775, 11668.416579170838, 11794.233374830608, 11866.940665296619, 11924.224925379822, 12165.878341216474, 12288.569900053455, 12340.876591234331, 12423.44094515767, 12647.557335493213, 8680.652773889226, 8879.91120088791, 8961.955190224267, 9062.682806101755, 9064.229540489132, 9236.445813251226, 11742.882571174521, 12097.697557561132, 12125.939370303093, 12196.268223906594], "value": 9650.9006505549, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.1362555215767, 1566.764985252212, 1571.756377761447, 1782.2870851659334, 1889.0649128681305, 7775.222477752222, 8338.124496927818, 8599.441036332633, 8615.43999640023, 8629.309655227582, 8441.62012709428, 8609.741707748763, 8631.395802293842, 8631.827363452727, 8638.913610863889, 2426.150847203478, 2454.0919859651863, 2454.202384225125, 2456.9754302457013, 2458.8032957363457, 2388.534235824015, 2426.369144022558, 2467.8889449974704, 2471.653968444419, 2485.0432583455317, 2377.2749311459997, 2400.051979468109, 2418.04487227545, 2440.9023639054417, 2442.218490083174, 2386.1052105460453, 2432.0393444589376, 2443.4013666651786, 2453.0555736041665, 2460.8400453970526, 2382.0590866607595, 2428.2229686500327, 2437.475942672334, 2442.755724427561, 2443.8655873926928, 7478.850422991564, 7656.885146722803, 8809.911900880974, 8819.559022048936, 8875.467471951704, 5240.135377662681, 5348.973255133738, 5388.5958553108285, 5395.325584301962, 5395.487428694268, 3446.5347178131133, 3484.5470088888537, 3504.877329293488, 3609.169890925076, 3626.7279954003557, 1144.896959273661, 1187.1155988788407, 1190.470240742861, 1209.8003829368145, 1228.4287806170173, 11628.76742465146, 11697.76604467906, 11738.765224695544, 12013.87986120145, 12089.637310880687, 4800.0639875224, 4804.543568361, 4878.048780487842, 4884.3650325458175, 4919.532644398776, 10355.223358248162, 10365.118964887919, 10375.377477351383, 10382.480875956171, 10421.218408619385, 5538.169274608841, 5543.2793736814765, 5551.0, 5551.72241387929, 5552.91670624941, 4988.027334669777, 4999.150144475448, 5039.647224694309, 5043.949560504421, 5055.570276526537, 4004.799760011988, 4038.919221615551, 4044.0698639313123, 4150.06623509714, 4157.355609880473, 1313.9934300328437, 1334.212814439466, 1354.7425989062046, 1359.327133069137, 1364.7748121559832, 982.7150126463246, 992.8212921674024, 998.6604554451521, 1003.0571263012745, 1008.3949630221808, 5925.4074592541265, 5940.168376427304, 5960.5231581474245, 6008.128821320884, 6134.294556126102, 476.6734786671141, 485.0, 486.2730218323558, 508.8931324421913, 511.66230288009734, 3455.9827200863833, 3928.194720082376, 4031.8185681644395, 4086.264472394938, 4094.4677191965447, 10402.791944161074, 10465.68602941913, 10470.947645261876, 10592.15262778976, 10640.414777187329, 10298.528353195179, 10301.484925753683, 10434.16526677864, 10527.420991845369, 10532.31539949916, 8109.351251899834, 8158.592070396457, 8195.590220489072, 8200.138985406566, 8220.712275070344, 5815.767369305349, 5820.330661973758, 5856.619319744203, 5981.401859813984, 6004.42957918997, 9425.764355890884, 9541.045895410682, 9650.420974741539, 9659.130678238993, 9751.56117974707, 9663.661771837951, 9799.51002449889, 9843.950780246052, 9914.752131196778, 10103.848442273518, 7536.5101268417375, 7619.466637335333, 7643.197464266172, 7645.961770191114, 7670.578118203553, 8082.878756818534, 8311.335093192409, 8333.583320834055, 8342.374321925758, 8366.958165209135, 7455.105387353552, 7579.393648507996, 7628.122765881994, 7635.770926872203, 7714.035745531809, 7213.1704853942465, 7353.338199562065, 7398.149212840593, 7441.962790186014, 7761.301482866569, 6580.7038683260325, 6604.570702904296, 6644.435223006099, 6653.733850646114, 6654.83362915931, 4922.360093187863, 4952.975235123801, 5065.772040258271, 5086.862269108154, 5194.636375453682, 5113.64204505681, 5138.537531622172, 5140.46025167352, 5162.09663308927, 5227.3465816772905], "value": 4580.4980292526725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.6845478660957, 367.43231707012654, 369.7079307347195, 375.2944464406916, 381.1766584178176, 6417.0, 6458.418742313191, 6464.3212462691445, 6486.545941784077, 6491.610503369801, 6069.302030266521, 6232.750689972407, 6392.073149393335, 6401.0, 6445.645489498076, 4896.926546101811, 4898.583620392271, 4903.289023091649, 4913.189323761575, 4916.852494425155, 4863.0, 4887.315775791392, 4905.8773530661665, 4909.68087074339, 4911.361523002005, 4692.882677933062, 4755.785989630475, 4770.356001939728, 4863.19757240055, 4884.6078867522765, 4844.442889067749, 4845.27320901864, 4873.195922672755, 4885.535874091991, 4890.853274401738, 4324.848630297956, 4328.307470804656, 4330.17726631939, 4332.588404101605, 4336.978315108436, 6147.72335244915, 6155.476784473325, 6158.445739883387, 6168.9691551541955, 6171.722272497748, 5759.5968282220265, 5759.90561793258, 5760.423957604248, 5761.740721667535, 5768.567357448166, 6634.966825165891, 6740.056392105109, 6778.898316525256, 6788.9660551696925, 6796.0, 4789.161896668104, 4815.398075240595, 4817.156997525454, 4823.059503396839, 4828.903421931577, 7008.159020917472, 7039.0, 7046.365827075537, 7048.471364647672, 7053.788386348367, 4923.655344125877, 4932.334134891816, 4934.358533390637, 4938.135826230396, 4943.060818444484, 4985.8005679772405, 4987.077390682735, 4988.0, 4988.9501104988485, 4994.101061808837, 5606.299212598426, 5675.318961724537, 5702.657840529581, 5706.600537962303, 5736.483716465538, 6770.424513916274, 6815.488838337045, 6816.182058152955, 6816.931830681729, 6820.3861652451515, 1740.095150521747, 1759.0, 1764.5676809181832, 1766.5936834528131, 1766.726157445598, 1101.0971003776826, 1161.1987728467332, 1187.9821802672966, 1189.4766302826729, 1195.3246415775059, 6553.311902250291, 6562.2453417856605, 6563.278039415661, 6575.276719560845, 6583.913654246996, 6981.685824137926, 6982.755603553953, 6988.545744526589, 6996.580205187705, 7002.719891204295, 6558.442532384705, 6562.146920900348, 6567.8358041048405, 6570.967145164243, 6603.570767900071, 3675.246574452231, 3707.073231692077, 3760.52993375828, 3762.398016317376, 3767.6420740029653, 7258.3104605062435, 7259.419246460376, 7289.198188199294, 7325.743598974011, 7350.448716346188, 7165.749198778018, 7169.784906452711, 7178.38983686382, 7189.137303523611, 7196.712131514785, 7277.672504737406, 7313.817154571178, 7318.121825380988, 7321.524100933422, 7345.77962661121, 6912.861742765217, 7038.260982596754, 7048.118985126859, 7058.082449281766, 7062.71749130029, 6949.68726407323, 6987.7204911802955, 6991.650417479004, 6991.685374158277, 6996.160460744743, 7325.963370183115, 7328.523645962995, 7330.816729581803, 7334.266573342623, 7341.74303899361, 4768.1417344878255, 4826.6621336507515, 4828.444728856227, 4829.348038014823, 4830.492798256132, 6894.24163342022, 7044.0, 7044.964775176091, 7046.2249152594195, 7055.435565154673, 6822.522423430312, 6833.214180369122, 6837.453003759588, 6844.897326540006, 6854.760083397057, 6759.831004224737, 6772.288909664611, 6787.66061696923, 6798.93201067983, 6813.04617353561, 6712.932870671426, 6722.327767223239, 6723.630200339028, 6724.394804467622, 6733.158355205599, 6668.899966500603, 6858.6570671467225, 6880.105586273752, 6882.655867206519, 6882.8623427530165, 6435.292117867125, 6524.314946930694, 6544.607323560602, 6556.475481961336, 6557.704903279268], "value": 5152.003769692786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.1072068877689, 765.8085478630343, 780.6096951524238, 804.9275565199134, 827.7516744976506, 13464.326783660814, 13483.865161348383, 13499.055066145374, 13604.0, 13619.38712757927, 12776.42506087226, 12813.935930320358, 12881.355932203376, 12920.0, 12928.93535532321, 739.7263012685314, 875.711015364928, 886.8581027035675, 888.995555022224, 896.2292428511475, 890.7372325164092, 894.1326912894482, 895.852184389575, 896.9013408525057, 899.1458114790942, 915.2403505090792, 918.9908100918972, 919.7608621758358, 921.806420651664, 921.9861702074475, 767.85794627994, 914.5244472874101, 918.3571499950028, 941.5292353823088, 942.9764255893589, 686.9828254293683, 692.6675195905943, 693.1820451866795, 693.4209934704528, 694.0144994108327, 14771.630709232248, 14804.111753294837, 14824.3329050193, 14882.776758348633, 14893.851061489355, 14515.564533064025, 14974.251287435585, 15001.774973375408, 15062.020968637004, 15137.394504219817, 11963.94018029913, 12029.338386388745, 12242.81635775464, 12246.510139594406, 12272.631821045383, 4041.191761647653, 4045.575214602454, 4062.228176646457, 4075.5109386873764, 4098.877033688965, 57618.42381576172, 57710.42289577134, 57743.42256577464, 58271.417285827025, 58382.70808645929, 10211.642592509226, 10477.31897426665, 10581.523831427605, 11189.776204476027, 11582.536698531965, 19639.901800490905, 19802.504937376394, 19822.306219282545, 19848.404547863298, 19905.303314383927, 8822.470651760786, 8900.732978010541, 9016.143466370684, 9021.278297736166, 9133.817323653622, 4752.6197904168275, 4791.856244312677, 4829.1307564638, 4859.173940430064, 4996.150654388763, 3403.081168084603, 3452.8100954447245, 3462.0306314232057, 3464.4630082337276, 3468.2716629508086, 649.2306616659274, 651.3681728723132, 658.7299207325069, 659.3406593406594, 662.9900551491731, 645.5577929118568, 661.5567569728197, 694.1254019934818, 709.8260926073145, 728.2535401213798, 9950.651727189514, 10025.949870250748, 10046.648367307256, 10091.798164036825, 10224.28430009907, 649.224177108351, 739.593223726948, 743.9696021010939, 752.3905636434506, 804.786731516137, 4261.488621365456, 4357.803898824561, 4368.514705000315, 4494.9325760113625, 4602.562756538124, 62718.68640656768, 63827.36172638214, 65235.0, 65379.67310163419, 65453.345466545674, 56368.43631563714, 56454.0, 58058.4194158053, 58071.4192858066, 58286.0, 51800.48199518032, 51947.70130746686, 52182.73908630508, 52247.216291755656, 52484.47515524796, 8058.3553315733425, 8198.877016844872, 8267.0, 8274.089850116603, 8312.958435207785, 39388.0, 39544.2091158181, 39881.60118398779, 39882.80058599688, 40601.79699101604, 48767.268490971954, 51177.74411127921, 51423.48576514336, 52176.0, 52225.21662174995, 10719.785604288027, 10874.075703565286, 10875.0, 10893.400862952614, 10930.344179349264, 11163.441827908735, 11526.88473115258, 11739.941300293443, 11939.16425850217, 12057.457414416196, 12353.135280530276, 12548.309842958724, 12696.238225706118, 12739.808902866649, 12876.613701588967, 11150.330980141218, 11506.0, 11569.363684997406, 11786.705332366759, 11979.820302695292, 12215.389230538616, 12284.938575307424, 12416.875831241572, 12551.246925184518, 13361.599152025456, 10298.256324731492, 10586.947065264625, 10633.89366106329, 10655.147588193082, 10667.519961601902, 10589.629362972259, 10717.356958582199, 10774.46127693628, 10880.183986201226, 10940.671779846618], "value": 6899.466196552407, "unit": "score"}], "name": "dromaeo_css", "value": 7496.641246081355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 111.0, 110.0, 110.0, 109.0, 113.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 155.0, 187.0, 128.0, 163.0, 150.0, 128.0, 177.0, 127.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 170.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 174.0, 76.0, 77.0, 74.0, 74.0, 161.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 151.0, 91.0, 93.0, 92.0, 154.0, 92.0, 94.0, 150.0], "value": 110.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 55.0, 54.0, 54.0, 53.0, 76.0, 55.0, 52.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 74.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 122.0, 114.0, 114.0, 112.0, 130.0, 137.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 156.0, 165.0, 154.0, 162.0, 157.0, 163.0, 161.0, 163.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 69.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1517.0, "alertThreshold": 2.0}]} 06:56:09 INFO - Return code: 0 06:56:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:56:09 ERROR - # TBPL SUCCESS # 06:56:09 INFO - Running post-action listener: _resource_record_post_action 06:56:09 INFO - Running post-run listener: _resource_record_post_run 06:56:10 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 461185024; Read time: 88; Write time: 1352024 06:56:10 INFO - install - Wall time: 14s; CPU: 22.0%; Read bytes: 4096; Write bytes: 239099904; Read time: 76; Write time: 1091248 06:56:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 218185728; Read time: 12; Write time: 214984 06:56:10 INFO - Running post-run listener: _upload_blobber_files 06:56:10 INFO - Blob upload gear active. 06:56:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:10 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 06:56:10 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:10 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:11 INFO - (blobuploader) - INFO - Done attempting. 06:56:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:12 INFO - (blobuploader) - INFO - Done attempting. 06:56:12 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:12 INFO - Return code: 0 06:56:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd8c0853cf7290e64424d8e393c2ef4ee7e5b62e34c0eef1a4cbab37ae06389519d4808db02919724c8439f00ef6ab3183d325ed44f3186447d2ae696b3274a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eec7347fe49e661a6f9c803cbd13599b0f820021a6149a7e3007fe83340126bb17393fdfce2041e7c3f15d4aee50d5eb12cae311775f304faa7cd7d656db551"} 06:56:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:12 INFO - Contents: 06:56:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd8c0853cf7290e64424d8e393c2ef4ee7e5b62e34c0eef1a4cbab37ae06389519d4808db02919724c8439f00ef6ab3183d325ed44f3186447d2ae696b3274a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eec7347fe49e661a6f9c803cbd13599b0f820021a6149a7e3007fe83340126bb17393fdfce2041e7c3f15d4aee50d5eb12cae311775f304faa7cd7d656db551"} 06:56:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:12 INFO - Copying logs to upload dir... 06:56:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.356644 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-09 06:56:12.029966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:56:12.033949) ========= 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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 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-Beta/sha512/cd8c0853cf7290e64424d8e393c2ef4ee7e5b62e34c0eef1a4cbab37ae06389519d4808db02919724c8439f00ef6ab3183d325ed44f3186447d2ae696b3274a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eec7347fe49e661a6f9c803cbd13599b0f820021a6149a7e3007fe83340126bb17393fdfce2041e7c3f15d4aee50d5eb12cae311775f304faa7cd7d656db551"} build_url:https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/fWoa-xBoR6arsQ6WidjrUg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd8c0853cf7290e64424d8e393c2ef4ee7e5b62e34c0eef1a4cbab37ae06389519d4808db02919724c8439f00ef6ab3183d325ed44f3186447d2ae696b3274a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3eec7347fe49e661a6f9c803cbd13599b0f820021a6149a7e3007fe83340126bb17393fdfce2041e7c3f15d4aee50d5eb12cae311775f304faa7cd7d656db551"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 06:56:12.063035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:56:12.063784) ========= 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=df17445c3590ff7897617a0e00000225-1465476797.348871-1479825052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:56:12.148544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:56:12.149305) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 06:56:12.149647) ========= ========= Total master_lag: 0.18 =========