builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1465432325.07 results: success (0) buildid: 20160608161732 builduid: c7513c2b072a4772b95d370c582276c8 revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.066892) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.067366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.067663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.082954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.083349) ========= 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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 17:32:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-06-08 17:32:05 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085541 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.182606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.182921) ========= 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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.232341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.232688) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 051765f8237daf5da7ba0d3e97da16668ce9988c --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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 17:32:05,459 truncating revision to first 12 chars 2016-06-08 17:32:05,459 Setting DEBUG logging. 2016-06-08 17:32:05,459 attempt 1/10 2016-06-08 17:32:05,459 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/051765f8237d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 17:32:05,770 unpacking tar archive at: mozilla-central-051765f8237d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631074 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.877503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.877889) ========= script_repo_revision: 051765f8237daf5da7ba0d3e97da16668ce9988c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.878294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.878564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:32:05.889461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-08 17:32:05.889771) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:32:06 INFO - MultiFileLogger online at 20160608 17:32:06 in /builds/slave/test 17:32:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:06 INFO - {'append_to_log': False, 17:32:06 INFO - 'base_work_dir': '/builds/slave/test', 17:32:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:06 INFO - 'branch': 'Firefox-Non-PGO', 17:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:06 INFO - 'config_files': ('talos/linux_config.py',), 17:32:06 INFO - 'default_actions': ('clobber', 17:32:06 INFO - 'read-buildbot-config', 17:32:06 INFO - 'download-and-extract', 17:32:06 INFO - 'populate-webroot', 17:32:06 INFO - 'create-virtualenv', 17:32:06 INFO - 'install', 17:32:06 INFO - 'run-tests'), 17:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:06 INFO - 'download_minidump_stackwalk': True, 17:32:06 INFO - 'download_symbols': 'ondemand', 17:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:06 INFO - 'installer_path': 'installer.exe', 17:32:06 INFO - 'log_level': 'info', 17:32:06 INFO - 'log_name': 'talos', 17:32:06 INFO - 'log_to_console': True, 17:32:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:32:06 INFO - 'opt_config_files': (), 17:32:06 INFO - 'pip_index': False, 17:32:06 INFO - 'sps_profile': False, 17:32:06 INFO - 'sps_profile_interval': 0, 17:32:06 INFO - 'suite': 'dromaeojs', 17:32:06 INFO - 'system_bits': '32', 17:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:06 INFO - 'title': 'talos-linux64-ix-043', 17:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:06 INFO - 'use_talos_json': True, 17:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:06 INFO - 'work_dir': 'build'} 17:32:06 INFO - ##### 17:32:06 INFO - ##### Running clobber step. 17:32:06 INFO - ##### 17:32:06 INFO - Running pre-action listener: _resource_record_pre_action 17:32:06 INFO - Running main action method: clobber 17:32:06 INFO - rmtree: /builds/slave/test/build 17:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:32:06 INFO - Running post-action listener: _resource_record_post_action 17:32:06 INFO - ##### 17:32:06 INFO - ##### Finished clobber step (success) 17:32:06 INFO - ##### 17:32:06 INFO - ##### 17:32:06 INFO - ##### Running read-buildbot-config step. 17:32:06 INFO - ##### 17:32:06 INFO - Running pre-action listener: _resource_record_pre_action 17:32:06 INFO - Running main action method: read_buildbot_config 17:32:06 INFO - Using buildbot properties: 17:32:06 INFO - { 17:32:06 INFO - "project": "", 17:32:06 INFO - "product": "firefox", 17:32:06 INFO - "script_repo_revision": "production", 17:32:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:32:06 INFO - "repository": "", 17:32:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:32:06 INFO - "buildid": "20160608161732", 17:32:06 INFO - "pgo_build": "False", 17:32:06 INFO - "basedir": "/builds/slave/test", 17:32:06 INFO - "buildnumber": 523, 17:32:06 INFO - "slavename": "talos-linux64-ix-043", 17:32:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:32:06 INFO - "platform": "ubuntu64_hw", 17:32:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:32:06 INFO - "branch": "mozilla-central", 17:32:06 INFO - "repo_path": "mozilla-central", 17:32:06 INFO - "revision": "051765f8237daf5da7ba0d3e97da16668ce9988c", 17:32:06 INFO - "stage_platform": "linux64", 17:32:06 INFO - "builduid": "c7513c2b072a4772b95d370c582276c8", 17:32:06 INFO - "slavebuilddir": "test" 17:32:06 INFO - } 17:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:32:06 INFO - Running post-action listener: _resource_record_post_action 17:32:06 INFO - ##### 17:32:06 INFO - ##### Finished read-buildbot-config step (success) 17:32:06 INFO - ##### 17:32:06 INFO - ##### 17:32:06 INFO - ##### Running download-and-extract step. 17:32:06 INFO - ##### 17:32:06 INFO - Running pre-action listener: _resource_record_pre_action 17:32:06 INFO - Running main action method: download_and_extract 17:32:06 INFO - mkdir: /builds/slave/test/build/tests 17:32:06 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')]} 17:32:06 INFO - https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:32:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:32:07 INFO - Downloaded 1361 bytes. 17:32:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:32:07 INFO - Using the following test package requirements: 17:32:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:32:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:32:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'jsshell-linux-x86_64.zip'], 17:32:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:32:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:32:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:32:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:32:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:32:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:32:07 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')]} 17:32:07 INFO - https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:08 INFO - Downloaded 22879023 bytes. 17:32:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:32:09 INFO - Return code: 0 17:32:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:32:09 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')]} 17:32:09 INFO - https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:32:12 INFO - Downloaded 22879023 bytes. 17:32:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:32:14 INFO - Return code: 0 17:32:14 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')]} 17:32:14 INFO - https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:32:15 INFO - Downloaded 10833369 bytes. 17:32:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:32:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:32:15 INFO - Return code: 0 17:32: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')]} 17:32:15 INFO - https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:32:19 INFO - Downloaded 55302911 bytes. 17:32:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:19 INFO - mkdir: /builds/slave/test/properties 17:32:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:32:19 INFO - Writing to file /builds/slave/test/properties/build_url 17:32:19 INFO - Contents: 17:32:19 INFO - build_url:https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:32:19 INFO - Running post-action listener: _resource_record_post_action 17:32:19 INFO - Running post-action listener: set_extra_try_arguments 17:32:19 INFO - ##### 17:32:19 INFO - ##### Finished download-and-extract step (success) 17:32:19 INFO - ##### 17:32:19 INFO - ##### 17:32:19 INFO - ##### Running populate-webroot step. 17:32:19 INFO - ##### 17:32:19 INFO - Running pre-action listener: _resource_record_pre_action 17:32:19 INFO - Running main action method: populate_webroot 17:32:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:32:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:32:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:32:19 INFO - '--tppagecycles', 17:32:19 INFO - '7'], 17:32:19 INFO - 'tests': ['tsvgm']}}, 17:32:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:32:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:32:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:32:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:32:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['damp', 'tps']}, 17:32:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'tests': ['damp', 'tps']}, 17:32:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['dromaeo_dom']}, 17:32:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:32:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'other-e10s': {'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['a11yr', 17:32:19 INFO - 'ts_paint', 17:32:19 INFO - 'tpaint', 17:32:19 INFO - 'sessionrestore', 17:32:19 INFO - 'sessionrestore_no_auto_restore', 17:32:19 INFO - 'tabpaint']}, 17:32:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['tsvgx', 17:32:19 INFO - 'tsvgr_opacity', 17:32:19 INFO - 'tart', 17:32:19 INFO - 'tscrollx', 17:32:19 INFO - 'cart']}, 17:32:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:32:19 INFO - 'tsvgr_opacity', 17:32:19 INFO - 'tart', 17:32:19 INFO - 'tscrollx', 17:32:19 INFO - 'cart']}, 17:32:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'talos_options': ['--disable-e10s'], 17:32:19 INFO - 'tests': ['tp5o']}, 17:32:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'tests': ['tp5o']}, 17:32:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'talos_options': ['--disable-e10s', 17:32:19 INFO - '--xperf_path', 17:32:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:19 INFO - 'tests': ['tp5n']}, 17:32:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:19 INFO - 'talos_options': ['--xperf_path', 17:32:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:19 INFO - 'tests': ['tp5n']}}, 17:32:19 INFO - 'talos.zip': {'path': '', 17:32:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:32:19 INFO - Running post-action listener: _resource_record_post_action 17:32:19 INFO - ##### 17:32:19 INFO - ##### Finished populate-webroot step (success) 17:32:19 INFO - ##### 17:32:19 INFO - ##### 17:32:19 INFO - ##### Running create-virtualenv step. 17:32:19 INFO - ##### 17:32:19 INFO - Running pre-action listener: _resource_record_pre_action 17:32:19 INFO - Running main action method: create_virtualenv 17:32:19 INFO - Creating virtualenv /builds/slave/test/build/venv 17:32:19 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 17:32:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:32:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:32:20 INFO - Using real prefix '/usr' 17:32:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:32:20 INFO - Installing distribute.............................................................................................................................................................................................done. 17:32:22 INFO - Installing pip.................done. 17:32:22 INFO - Return code: 0 17:32:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:32:22 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')]} 17:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:22 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')]} 17:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:22 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:22 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 17:32:22 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 17:32:22 INFO - Using env: {'DISPLAY': ':0', 17:32:22 INFO - 'HOME': '/home/cltbld', 17:32:22 INFO - 'LANG': 'en_US.UTF-8', 17:32:22 INFO - 'LANGUAGE': 'en_US:en', 17:32:22 INFO - 'LOGNAME': 'cltbld', 17:32:22 INFO - 'MAIL': '/var/mail/cltbld', 17:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:22 INFO - 'MOZ_NO_REMOTE': '1', 17:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:22 INFO - 'NO_EM_RESTART': '1', 17:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:22 INFO - 'PWD': '/builds/slave/test', 17:32:22 INFO - 'SHELL': '/bin/bash', 17:32:22 INFO - 'SHLVL': '1', 17:32:22 INFO - 'TERM': 'linux', 17:32:22 INFO - 'TMOUT': '86400', 17:32:22 INFO - 'USER': 'cltbld', 17:32:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:22 INFO - '_': '/tools/buildbot/bin/python'} 17:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:22 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 17:32:22 INFO - Cleaning up... 17:32:22 INFO - Return code: 0 17:32:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:32:22 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')]} 17:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:22 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')]} 17:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:22 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:22 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>=3.1.1'] in /builds/slave/test/build 17:32:22 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>=3.1.1 17:32:22 INFO - Using env: {'DISPLAY': ':0', 17:32:22 INFO - 'HOME': '/home/cltbld', 17:32:22 INFO - 'LANG': 'en_US.UTF-8', 17:32:22 INFO - 'LANGUAGE': 'en_US:en', 17:32:22 INFO - 'LOGNAME': 'cltbld', 17:32:22 INFO - 'MAIL': '/var/mail/cltbld', 17:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:22 INFO - 'MOZ_NO_REMOTE': '1', 17:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:22 INFO - 'NO_EM_RESTART': '1', 17:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:22 INFO - 'PWD': '/builds/slave/test', 17:32:22 INFO - 'SHELL': '/bin/bash', 17:32:22 INFO - 'SHLVL': '1', 17:32:22 INFO - 'TERM': 'linux', 17:32:22 INFO - 'TMOUT': '86400', 17:32:22 INFO - 'USER': 'cltbld', 17:32:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:22 INFO - '_': '/tools/buildbot/bin/python'} 17:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:22 INFO - Downloading/unpacking psutil>=3.1.1 17:32:22 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 17:32:22 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 17:32:22 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 17:32:22 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 17:32:22 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 17:32:22 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 17:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:24 INFO - Installing collected packages: psutil 17:32:24 INFO - Running setup.py install for psutil 17:32:25 INFO - building 'psutil._psutil_linux' extension 17:32:25 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 17:32:25 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 17:32:25 INFO - building 'psutil._psutil_posix' extension 17:32:25 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 17:32:25 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 17:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:25 INFO - Successfully installed psutil 17:32:25 INFO - Cleaning up... 17:32:25 INFO - Return code: 0 17:32:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:32:25 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')]} 17:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:25 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')]} 17:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:25 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:25 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.3'] in /builds/slave/test/build 17:32:25 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.3 17:32:25 INFO - Using env: {'DISPLAY': ':0', 17:32:25 INFO - 'HOME': '/home/cltbld', 17:32:25 INFO - 'LANG': 'en_US.UTF-8', 17:32:25 INFO - 'LANGUAGE': 'en_US:en', 17:32:25 INFO - 'LOGNAME': 'cltbld', 17:32:25 INFO - 'MAIL': '/var/mail/cltbld', 17:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:25 INFO - 'MOZ_NO_REMOTE': '1', 17:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:25 INFO - 'NO_EM_RESTART': '1', 17:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:25 INFO - 'PWD': '/builds/slave/test', 17:32:25 INFO - 'SHELL': '/bin/bash', 17:32:25 INFO - 'SHLVL': '1', 17:32:25 INFO - 'TERM': 'linux', 17:32:25 INFO - 'TMOUT': '86400', 17:32:25 INFO - 'USER': 'cltbld', 17:32:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:25 INFO - '_': '/tools/buildbot/bin/python'} 17:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:32:25 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 17:32:25 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 17:32:25 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 17:32:25 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 17:32:25 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 17:32:25 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 17:32:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:32:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:32:27 INFO - Installing collected packages: mozsystemmonitor 17:32:27 INFO - Running setup.py install for mozsystemmonitor 17:32:27 INFO - Successfully installed mozsystemmonitor 17:32:27 INFO - Cleaning up... 17:32:27 INFO - Return code: 0 17:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:32:27 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')]} 17:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:27 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')]} 17:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:27 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:27 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==2.5.1'] in /builds/slave/test/build 17:32:27 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==2.5.1 17:32:27 INFO - Using env: {'DISPLAY': ':0', 17:32:27 INFO - 'HOME': '/home/cltbld', 17:32:27 INFO - 'LANG': 'en_US.UTF-8', 17:32:27 INFO - 'LANGUAGE': 'en_US:en', 17:32:27 INFO - 'LOGNAME': 'cltbld', 17:32:27 INFO - 'MAIL': '/var/mail/cltbld', 17:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:27 INFO - 'MOZ_NO_REMOTE': '1', 17:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:27 INFO - 'NO_EM_RESTART': '1', 17:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:27 INFO - 'PWD': '/builds/slave/test', 17:32:27 INFO - 'SHELL': '/bin/bash', 17:32:27 INFO - 'SHLVL': '1', 17:32:27 INFO - 'TERM': 'linux', 17:32:27 INFO - 'TMOUT': '86400', 17:32:27 INFO - 'USER': 'cltbld', 17:32:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:27 INFO - '_': '/tools/buildbot/bin/python'} 17:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:27 INFO - Downloading/unpacking jsonschema==2.5.1 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:27 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 17:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:29 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 17:32:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:32:30 INFO - warning: no files found matching '*.txt' 17:32:30 INFO - no previously-included directories found matching 'build' 17:32:30 INFO - no previously-included directories found matching 'dist' 17:32:30 INFO - no previously-included directories found matching '.git*' 17:32:30 INFO - Installing collected packages: jsonschema, functools32 17:32:30 INFO - Running setup.py install for functools32 17:32:30 INFO - warning: no files found matching '*.txt' 17:32:30 INFO - no previously-included directories found matching 'build' 17:32:30 INFO - no previously-included directories found matching 'dist' 17:32:30 INFO - no previously-included directories found matching '.git*' 17:32:30 INFO - Successfully installed jsonschema functools32 17:32:30 INFO - Cleaning up... 17:32:30 INFO - Return code: 0 17:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:32:30 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')]} 17:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:30 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')]} 17:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:30 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:30 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 17:32:30 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 17:32:30 INFO - Using env: {'DISPLAY': ':0', 17:32:30 INFO - 'HOME': '/home/cltbld', 17:32:30 INFO - 'LANG': 'en_US.UTF-8', 17:32:30 INFO - 'LANGUAGE': 'en_US:en', 17:32:30 INFO - 'LOGNAME': 'cltbld', 17:32:30 INFO - 'MAIL': '/var/mail/cltbld', 17:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:30 INFO - 'MOZ_NO_REMOTE': '1', 17:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:30 INFO - 'NO_EM_RESTART': '1', 17:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:30 INFO - 'PWD': '/builds/slave/test', 17:32:30 INFO - 'SHELL': '/bin/bash', 17:32:30 INFO - 'SHLVL': '1', 17:32:30 INFO - 'TERM': 'linux', 17:32:30 INFO - 'TMOUT': '86400', 17:32:30 INFO - 'USER': 'cltbld', 17:32:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:30 INFO - '_': '/tools/buildbot/bin/python'} 17:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 17:32:30 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 17:32:30 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 17:32:30 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 17:32:30 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 17:32:30 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 17:32:30 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 17:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:32:32 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 17:32:32 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 17:32:32 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 17:32:32 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 17:32:32 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 17:32:32 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 17:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 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 17:32:33 INFO - Downloading docopt-0.6.1.tar.gz 17:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:32:33 INFO - Running setup.py install for blobuploader 17:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:32:33 INFO - Running setup.py install for requests 17:32:33 INFO - Running setup.py install for docopt 17:32:33 INFO - Successfully installed blobuploader requests docopt 17:32:33 INFO - Cleaning up... 17:32:33 INFO - Return code: 0 17:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:33 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:33 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 17:32:33 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 17:32:33 INFO - Using env: {'DISPLAY': ':0', 17:32:33 INFO - 'HOME': '/home/cltbld', 17:32:33 INFO - 'LANG': 'en_US.UTF-8', 17:32:33 INFO - 'LANGUAGE': 'en_US:en', 17:32:33 INFO - 'LOGNAME': 'cltbld', 17:32:33 INFO - 'MAIL': '/var/mail/cltbld', 17:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:33 INFO - 'MOZ_NO_REMOTE': '1', 17:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:33 INFO - 'NO_EM_RESTART': '1', 17:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:33 INFO - 'PWD': '/builds/slave/test', 17:32:33 INFO - 'SHELL': '/bin/bash', 17:32:33 INFO - 'SHLVL': '1', 17:32:33 INFO - 'TERM': 'linux', 17:32:33 INFO - 'TMOUT': '86400', 17:32:33 INFO - 'USER': 'cltbld', 17:32:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:33 INFO - '_': '/tools/buildbot/bin/python'} 17:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:34 INFO - Running setup.py (path:/tmp/pip-WQjJLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:34 INFO - Running setup.py (path:/tmp/pip-A21rEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:34 INFO - Running setup.py (path:/tmp/pip-VzNhUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:34 INFO - Running setup.py (path:/tmp/pip-02MXNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:34 INFO - Running setup.py (path:/tmp/pip-TUxuuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:34 INFO - Running setup.py (path:/tmp/pip-haZ0g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:34 INFO - Running setup.py (path:/tmp/pip-9EkIC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:34 INFO - Running setup.py (path:/tmp/pip-yANueV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:34 INFO - Running setup.py (path:/tmp/pip-V_LDjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:34 INFO - Running setup.py (path:/tmp/pip-I1g1td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:34 INFO - Running setup.py (path:/tmp/pip-5IODn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:34 INFO - Running setup.py (path:/tmp/pip-nP8Q01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:35 INFO - Running setup.py (path:/tmp/pip-p2s5Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:35 INFO - Running setup.py (path:/tmp/pip-90dDxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:35 INFO - Running setup.py (path:/tmp/pip-IyvyeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:35 INFO - Running setup.py (path:/tmp/pip-9ftJFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:35 INFO - Running setup.py (path:/tmp/pip-76DgX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:35 INFO - Running setup.py install for manifestparser 17:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:35 INFO - Running setup.py install for mozcrash 17:32:35 INFO - Running setup.py install for mozdebug 17:32:35 INFO - Running setup.py install for mozdevice 17:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:35 INFO - Running setup.py install for mozfile 17:32:35 INFO - Running setup.py install for mozhttpd 17:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozinfo 17:32:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozInstall 17:32:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozleak 17:32:36 INFO - Running setup.py install for mozlog 17:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for moznetwork 17:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozprocess 17:32:36 INFO - Running setup.py install for mozprofile 17:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozrunner 17:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:36 INFO - Running setup.py install for mozscreenshot 17:32:36 INFO - Running setup.py install for moztest 17:32:37 INFO - Running setup.py install for mozversion 17:32:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:37 INFO - Cleaning up... 17:32:37 INFO - Return code: 0 17:32:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:37 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:37 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 17:32:37 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 17:32:37 INFO - Using env: {'DISPLAY': ':0', 17:32:37 INFO - 'HOME': '/home/cltbld', 17:32:37 INFO - 'LANG': 'en_US.UTF-8', 17:32:37 INFO - 'LANGUAGE': 'en_US:en', 17:32:37 INFO - 'LOGNAME': 'cltbld', 17:32:37 INFO - 'MAIL': '/var/mail/cltbld', 17:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:37 INFO - 'MOZ_NO_REMOTE': '1', 17:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:37 INFO - 'NO_EM_RESTART': '1', 17:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:37 INFO - 'PWD': '/builds/slave/test', 17:32:37 INFO - 'SHELL': '/bin/bash', 17:32:37 INFO - 'SHLVL': '1', 17:32:37 INFO - 'TERM': 'linux', 17:32:37 INFO - 'TMOUT': '86400', 17:32:37 INFO - 'USER': 'cltbld', 17:32:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:37 INFO - '_': '/tools/buildbot/bin/python'} 17:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:37 INFO - Running setup.py (path:/tmp/pip-ede0F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:37 INFO - Running setup.py (path:/tmp/pip-BchK_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:37 INFO - Running setup.py (path:/tmp/pip-dyuH5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:37 INFO - Running setup.py (path:/tmp/pip-Xqlsgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:37 INFO - Running setup.py (path:/tmp/pip-6Omqez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:37 INFO - Running setup.py (path:/tmp/pip-y7JgbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:37 INFO - Running setup.py (path:/tmp/pip-xSDjn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:37 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)) 17:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:37 INFO - Running setup.py (path:/tmp/pip-_vESxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:38 INFO - Running setup.py (path:/tmp/pip-swbEcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:38 INFO - Running setup.py (path:/tmp/pip-ywoIPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:38 INFO - Running setup.py (path:/tmp/pip-egHDiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:38 INFO - Running setup.py (path:/tmp/pip-jV7wyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:38 INFO - Running setup.py (path:/tmp/pip-gQLBsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:38 INFO - Running setup.py (path:/tmp/pip-D28AS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:38 INFO - Running setup.py (path:/tmp/pip-SKMfc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:38 INFO - Running setup.py (path:/tmp/pip-Q4_mD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:38 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)) 17:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:38 INFO - Running setup.py (path:/tmp/pip-4_1TZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:38 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)) 17:32:38 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)) 17:32:38 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)) 17:32:38 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)) 17:32:38 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)) 17:32:38 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)) 17:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:38 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 17:32:40 INFO - Downloading blessings-1.6.tar.gz 17:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:40 INFO - Installing collected packages: blessings 17:32:40 INFO - Running setup.py install for blessings 17:32:40 INFO - Successfully installed blessings 17:32:40 INFO - Cleaning up... 17:32:40 INFO - Return code: 0 17:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:41 INFO - Reading from file tmpfile_stdout 17:32:41 INFO - Current package versions: 17:32:41 INFO - argparse == 1.2.1 17:32:41 INFO - blessings == 1.6 17:32:41 INFO - blobuploader == 1.2.4 17:32:41 INFO - docopt == 0.6.1 17:32:41 INFO - functools32 == 3.2.3-2 17:32:41 INFO - jsonschema == 2.5.1 17:32:41 INFO - manifestparser == 1.1 17:32:41 INFO - mozInstall == 1.12 17:32:41 INFO - mozcrash == 0.17 17:32:41 INFO - mozdebug == 0.1 17:32:41 INFO - mozdevice == 0.48 17:32:41 INFO - mozfile == 1.2 17:32:41 INFO - mozhttpd == 0.7 17:32:41 INFO - mozinfo == 0.9 17:32:41 INFO - mozleak == 0.1 17:32:41 INFO - mozlog == 3.2 17:32:41 INFO - moznetwork == 0.27 17:32:41 INFO - mozprocess == 0.22 17:32:41 INFO - mozprofile == 0.28 17:32:41 INFO - mozrunner == 6.11 17:32:41 INFO - mozscreenshot == 0.1 17:32:41 INFO - mozsystemmonitor == 0.3 17:32:41 INFO - moztest == 0.7 17:32:41 INFO - mozversion == 1.4 17:32:41 INFO - psutil == 3.1.1 17:32:41 INFO - requests == 1.2.3 17:32:41 INFO - wsgiref == 0.1.2 17:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:41 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')]} 17:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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')]} 17:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:41 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 17:32:41 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 17:32:41 INFO - Using env: {'DISPLAY': ':0', 17:32:41 INFO - 'HOME': '/home/cltbld', 17:32:41 INFO - 'LANG': 'en_US.UTF-8', 17:32:41 INFO - 'LANGUAGE': 'en_US:en', 17:32:41 INFO - 'LOGNAME': 'cltbld', 17:32:41 INFO - 'MAIL': '/var/mail/cltbld', 17:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:41 INFO - 'MOZ_NO_REMOTE': '1', 17:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:41 INFO - 'NO_EM_RESTART': '1', 17:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:41 INFO - 'PWD': '/builds/slave/test', 17:32:41 INFO - 'SHELL': '/bin/bash', 17:32:41 INFO - 'SHLVL': '1', 17:32:41 INFO - 'TERM': 'linux', 17:32:41 INFO - 'TMOUT': '86400', 17:32:41 INFO - 'USER': 'cltbld', 17:32:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:41 INFO - '_': '/tools/buildbot/bin/python'} 17:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 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)) 17:32:41 INFO - Cleaning up... 17:32:41 INFO - Return code: 0 17:32:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32:41 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')]} 17:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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')]} 17:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:41 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 17:32:41 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 17:32:41 INFO - Using env: {'DISPLAY': ':0', 17:32:41 INFO - 'HOME': '/home/cltbld', 17:32:41 INFO - 'LANG': 'en_US.UTF-8', 17:32:41 INFO - 'LANGUAGE': 'en_US:en', 17:32:41 INFO - 'LOGNAME': 'cltbld', 17:32:41 INFO - 'MAIL': '/var/mail/cltbld', 17:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:41 INFO - 'MOZ_NO_REMOTE': '1', 17:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:41 INFO - 'NO_EM_RESTART': '1', 17:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:41 INFO - 'PWD': '/builds/slave/test', 17:32:41 INFO - 'SHELL': '/bin/bash', 17:32:41 INFO - 'SHLVL': '1', 17:32:41 INFO - 'TERM': 'linux', 17:32:41 INFO - 'TMOUT': '86400', 17:32:41 INFO - 'USER': 'cltbld', 17:32:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:41 INFO - '_': '/tools/buildbot/bin/python'} 17:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:32:41 INFO - Cleaning up... 17:32:41 INFO - Return code: 0 17:32:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:32:41 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')]} 17:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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')]} 17:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:41 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 0x7fd0d7e64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, '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': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', '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 17:32:41 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 17:32:41 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 17:32:41 INFO - Using env: {'DISPLAY': ':0', 17:32:41 INFO - 'HOME': '/home/cltbld', 17:32:41 INFO - 'LANG': 'en_US.UTF-8', 17:32:41 INFO - 'LANGUAGE': 'en_US:en', 17:32:41 INFO - 'LOGNAME': 'cltbld', 17:32:41 INFO - 'MAIL': '/var/mail/cltbld', 17:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:41 INFO - 'MOZ_NO_REMOTE': '1', 17:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:41 INFO - 'NO_EM_RESTART': '1', 17:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:41 INFO - 'PWD': '/builds/slave/test', 17:32:41 INFO - 'SHELL': '/bin/bash', 17:32:41 INFO - 'SHLVL': '1', 17:32:41 INFO - 'TERM': 'linux', 17:32:41 INFO - 'TMOUT': '86400', 17:32:41 INFO - 'USER': 'cltbld', 17:32:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:41 INFO - '_': '/tools/buildbot/bin/python'} 17:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:41 INFO - Downloading/unpacking flake8 17:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:32:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:32:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:43 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 17:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:44 INFO - no previously-included directories found matching 'docs/_build' 17:32:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:32:44 INFO - Running setup.py install for pep8 17:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:44 INFO - no previously-included directories found matching 'docs/_build' 17:32:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:32:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:32:44 INFO - Cleaning up... 17:32:44 INFO - Return code: 0 17:32:44 INFO - Running post-action listener: _resource_record_post_action 17:32:44 INFO - Running post-action listener: _start_resource_monitoring 17:32:44 INFO - Starting resource monitoring. 17:32:44 INFO - ##### 17:32:44 INFO - ##### Finished create-virtualenv step (success) 17:32:44 INFO - ##### 17:32:44 INFO - ##### 17:32:44 INFO - ##### Running install step. 17:32:44 INFO - ##### 17:32:44 INFO - Running pre-action listener: _resource_record_pre_action 17:32:44 INFO - Running main action method: install 17:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:44 INFO - Reading from file tmpfile_stdout 17:32:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:44 INFO - Reading from file tmpfile_stdout 17:32:44 INFO - Output received: 17:32:44 INFO - Usage: mozinstall [options] installer 17:32:44 INFO - Options: 17:32:44 INFO - -h, --help show this help message and exit 17:32:44 INFO - -d DEST, --destination=DEST 17:32:44 INFO - Directory to install application into. [default: 17:32:44 INFO - "/builds/slave/test"] 17:32:44 INFO - --app=APP Application being installed. [default: firefox] 17:32:44 INFO - mkdir: /builds/slave/test/build/application 17:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:33:00 INFO - Reading from file tmpfile_stdout 17:33:00 INFO - Output received: 17:33:00 INFO - /builds/slave/test/build/application/firefox/firefox 17:33:00 INFO - Running post-action listener: _resource_record_post_action 17:33:00 INFO - ##### 17:33:00 INFO - ##### Finished install step (success) 17:33:00 INFO - ##### 17:33:00 INFO - ##### 17:33:00 INFO - ##### Running run-tests step. 17:33:00 INFO - ##### 17:33:00 INFO - Running pre-action listener: _resource_record_pre_action 17:33:00 INFO - Running main action method: run_tests 17:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:33:00 INFO - Python 2.7.3 17:33:00 INFO - Return code: 0 17:33:00 INFO - grabbing minidump binary from tooltool 17:33:00 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')]} 17:33:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b1c0>, '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 0x1d6c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:33:00 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 17:33:00 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 17:33:00 INFO - Calling ['/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'] with output_timeout 600 17:33:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:33:00 INFO - Return code: 0 17:33:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:33:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:33:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:33:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:33:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:33:01 INFO - Return code: 0 17:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 17:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 17:33:01 INFO - Using env: {'DISPLAY': ':0', 17:33:01 INFO - 'HOME': '/home/cltbld', 17:33:01 INFO - 'LANG': 'en_US.UTF-8', 17:33:01 INFO - 'LANGUAGE': 'en_US:en', 17:33:01 INFO - 'LOGNAME': 'cltbld', 17:33:01 INFO - 'MAIL': '/var/mail/cltbld', 17:33:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:01 INFO - 'MOZ_NO_REMOTE': '1', 17:33:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:01 INFO - 'NO_EM_RESTART': '1', 17:33:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:01 INFO - 'PWD': '/builds/slave/test', 17:33:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:01 INFO - 'SHELL': '/bin/bash', 17:33:01 INFO - 'SHLVL': '1', 17:33:01 INFO - 'TERM': 'linux', 17:33:01 INFO - 'TMOUT': '86400', 17:33:01 INFO - 'USER': 'cltbld', 17:33:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279', 17:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:01 INFO - '_': '/tools/buildbot/bin/python'} 17:33:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 17:33:02 INFO - mozversion application_buildid: 20160608161732 17:33:02 INFO - mozversion application_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 17:33:02 INFO - mozversion application_display_name: Nightly 17:33:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:33:02 INFO - mozversion application_name: Firefox 17:33:02 INFO - mozversion application_remotingname: firefox 17:33:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:33:02 INFO - mozversion application_vendor: Mozilla 17:33:02 INFO - mozversion application_version: 50.0a1 17:33:02 INFO - mozversion platform_buildid: 20160608161732 17:33:02 INFO - mozversion platform_changeset: 051765f8237daf5da7ba0d3e97da16668ce9988c 17:33:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:33:02 INFO - mozversion platform_version: 50.0a1 17:33:02 INFO - using testdate: 1465432382 17:33:02 INFO - actual date: 1465432382 17:33:02 INFO - starting webserver on 'localhost:46465' 17:33:02 INFO - SUITE-START | Running 2 tests 17:33:02 INFO - TEST-START | dromaeo_css 17:33:02 INFO - operating with platform_type : linux_ 17:33:02 INFO - Initialising browser for dromaeo_css test... 17:33:02 INFO - TEST-INFO | started process 31995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZbTiF/profile http://localhost:46465/getInfo.html) 17:33:06 INFO - PROCESS | 31995 | __metrics Screen width/height:1600/1200 17:33:06 INFO - PROCESS | 31995 | colorDepth:24 17:33:06 INFO - PROCESS | 31995 | Browser inner width/height: 1024/697 17:33:06 INFO - PROCESS | 31995 | __metrics 17:33:07 ERROR - PROCESS | 31995 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:33:08 INFO - PROCESS | 31995 | console.error: PushService: 17:33:08 INFO - PROCESS | 31995 | stateChangeProcessEnqueue: Error transitioning state 17:33:08 INFO - PROCESS | 31995 | UnknownError 17:33:08 INFO - TEST-INFO | 31995: exit 0 17:33:08 INFO - Browser initialized. 17:33:08 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:08 INFO - TEST-INFO | started process 32075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZbTiF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:20 INFO - PROCESS | 32075 | RSS: Main: 157650944 17:33:20 INFO - PROCESS | 32075 | 17:34:12 INFO - PROCESS | 32075 | 1465432452274 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] 17:36:23 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46465/tests/dromaeo/cssquery-ext.html) 17:36:24 INFO - PROCESS | 32075 | RSS: Main: 238850048 17:36:24 INFO - PROCESS | 32075 | 17:39:27 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-ext.html (next: http://localhost:46465/tests/dromaeo/cssquery-jquery.html) 17:39:28 INFO - PROCESS | 32075 | RSS: Main: 240099328 17:39:28 INFO - PROCESS | 32075 | 17:42:30 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46465/tests/dromaeo/cssquery-mootools.html) 17:42:30 INFO - PROCESS | 32075 | RSS: Main: 245080064 17:42:30 INFO - PROCESS | 32075 | 17:45:33 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46465/tests/dromaeo/cssquery-prototype.html) 17:45:33 INFO - PROCESS | 32075 | RSS: Main: 242024448 17:45:33 INFO - PROCESS | 32075 | 17:48:36 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46465/tests/dromaeo/cssquery-yui.html) 17:48:37 INFO - PROCESS | 32075 | RSS: Main: 213258240 17:48:37 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | Cycle 1(1): loaded http://localhost:46465/tests/dromaeo/cssquery-yui.html (next: http://localhost:46465/tests/dromaeo/cssquery-dojo.html) 17:51:40 INFO - PROCESS | 32075 | RSS: Main: 281985024 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | __start_tp_report 17:51:40 INFO - PROCESS | 32075 | _x_x_mozilla_page_load 17:51:40 INFO - PROCESS | 32075 | _x_x_mozilla_page_load_details 17:51:40 INFO - PROCESS | 32075 | |i|pagename|runs| 17:51:40 INFO - PROCESS | 32075 | |0;dojo.html;2641.3000554852965;2655.668041494813;2672.5590277604197;2690.771284440821;2694.5419278722616;4500.23496005679;4588.7935042923145;4617.445906491217;4666.136764698533;4749.263864101065;4656.697314674552;4670.369500117483;4674.672772905898;4703.200455922492;4717.150912835688;4085.468889044435;4254.127903779726;4338.84814031509;4365.781710914457;4409.250427427329;4323.1353729254115;4362.563743625644;4374.103308821684;4380.08018316154;4407.206702793496;4158.604932531404;4196.139791342767;4295.463067116611;4332.545082766295;4339.349097635349;4283.550227226127;4286.57134286572;4300.913981720348;4339.652827773771;4354.869353919387;4287.635550978171;4309.719868208556;4340.587644173798;4381.78091095444;4383.430154079949;4457.24226881431;4521.163584736834;4583.9541604583865;4591.563801438858;4605.884852878671;4965.453800081988;5000.649954503187;5005.374328208974;5021.271915572222;5027.547520723116;5037.647364684473;5047.596192304607;5050.166722490784;5057.822976195852;5060.924086138711;4540.8637740867825;4614.446266448048;4621.907561848811;4623.190941585209;4666.183417901853;5130.948690513122;5142.794288228504;5154.845354639292;5158.0199762045095;5158.303629010035;4784.30627559002;4949.257611358325;4952.108620448354;4964.925526117111;4966.15575352191;4987.251912213124;5026.824061157842;5027.723475208899;5038.496150385005;5046.091703493406;4977.527134922177;4984.4267909190185;4993.925091123636;4996.2505624156665;5036.597072234213;4840.806367745321;4850.151223535867;4976.726280054631;4980.601551875841;5027.321311622884;4188.246115699142;4193.769342686121;4198.895027624334;4214.536400995888;4233.449651545279;3660.926781464356;3691.7231207659534;3695.2609478104487;3723.906902327409;3732.141607430306;4141.97929010353;4190.413342132104;4239.8092085856215;4245.490541135084;4248.150369926027;4963.875903102451;4992.2511623256805;5002.099622068063;5002.674826136289;5049.318342023853;4270.871873843789;4272.166927449118;4275.0381164238415;4290.099079193405;4322.783860806947;4367.62875155609;4467.776611169428;4485.798139083749;4489.438820147481;4532.841350552715;4786.880327991828;4806.831760888352;4809.062232864558;4841.419029716457;4854.80580776765;5065.442801291929;5071.315372424676;5080.923786143285;5085.77114029877;5089.720065396439;4596.954030459653;4699.671023028355;4748.62011039123;4761.547652972962;4839.733814640229;4962.42932062803;4973.726445045412;4976.30331753562;4981.800727970841;5011.323471331323;5010.674306170087;5030.346055012825;5039.168537191323;5049.798008079636;5094.745262736774;4753.382060332135;4877.707337559757;4911.901761964812;4932.260160975882;4940.258961155855;4914.803407863646;4950.183219768842;4953.504649535162;4964.3298154748645;5012.04771093491;4643.210654188729;4867.099586576494;4874.488178741181;4876.439209490812;4920.655554111321;4875.146849301287;4882.804687812448;4902.803887844446;4913.263010548446;4935.333729946555;4820.783064762164;4830.227163653799;4842.7578621068105;4846.055019271208;4897.36334276556 17:51:40 INFO - PROCESS | 32075 | |1;ext.html;579.339552909683;586.4399498478953;588.5879884081145;591.3642833953498;602.1599868183882;26888.59667104995;29546.704532954693;37748.81125594375;38866.417003744966;39029;40038.59961400385;40493.190136197256;40505.18989620206;40521;40559.39160912589;7640.847183056336;7772.922270777276;7774.455788094836;7779.716346802771;7782.416318776114;7654.961725191394;7747.922520774777;7748.6125693715085;7755.069391673007;7758.262965018314;7755.844883102334;7783.727569535067;7798.220177982184;7803.5708036057995;7803.921960780404;7709;7756.146823849372;7759.8448031039625;7762.37900967924;7768.883466748003;7741.071071471403;7818.8827167592535;7827.491213071132;7844.646990885424;7848.529088254723;31873.681263187304;32040.519392209135;32073;32085.6791432085;32088;3028.1369809604375;3045.6954304569585;3141.387429451258;3142.9685703142904;3169.9366012679848;28102;28630.284242893886;28998.588165357913;29155.854220728972;30204.24489387761;3000.6249218847643;3237.14215732831;3295.9011229663147;3345.8159801210923;3401.3197360527993;197952;258891;259194;259226;260673;31095.533566996513;54165.45834541683;54945.1758223627;54951;54965.450345496836;31887.202819929687;34015.97952061442;34080.829595851865;34104.317913641586;34116.65883341184;13320.267385293708;13597.592072237849;13598.796018059737;13609.727805444034;13612.387442565108;11236.83144752813;11482.311061336346;11483.196176267582;11502.539898404137;11513.712157196138;7882.645280962371;7882.846861255543;7884.802879928047;7939.722109726132;7971.40214483916;3070.462669032955;3078.415101130778;3085.4291955988215;3109.2382366319944;3151.9212019699235;842.2924743215729;893.6023469555985;895.3329769321766;901.1619194149373;930.916217540411;27325.726742732717;28027.546777546893;28175.15474535767;28829.279268018046;28887.133385998455;951.8952915179325;964.320154291223;974.3206182996759;988.7824678570703;1032.8192566300868;14457.85542144565;14744.410223590936;14753.483628072965;15025.549233523012;15143.394264229528;401143;405281;405521;405704;408852;49792.75103624459;50474;50546.74726626343;50558.74720626447;50608.746956264986;1091.165258577189;1153.8903804138592;1226.405193481161;1234.4383305595932;1245.1968480330136;27991.58012629853;28881.277968050967;29089.563656545593;29198.195903322197;29527.409451811272;40381.394279086424;40418.19163616652;40836.1832763349;40849;40850.1829963405;290555;293054;293184;293331;294618;22613.20853770176;23627.29118126459;24526.509469810862;24679.136230231856;24834.627480588166;41264.381034285114;41278.38082428706;42340.576594233666;42667.3599896008;42771.144577108906;35143.47284790781;35723.28553428969;35989.28021439609;36300.455493167094;36752.44871326879;35153;36038.639613603526;36089;36474;36657.45013824741;35213.119672008404;35547.64452355443;35758.8212058938;36228.63771362253;36319;30916.690833091383;31764.682353176173;32279.677203227668;32566.34867302688;32696;24776;25035.49929001446;25364.239394824777;25445.10942117017;25467.23598292054 17:51:40 INFO - PROCESS | 32075 | |2;jquery.html;347.5957133181943;348.49816264579005;355.4419561288777;372.19419955795706;376.3414025455453;15888.364465421384;16491.175441227937;16988.405405810798;17011.149442527854;17037.7444338335;14393.64015899603;14700.926495367536;15115.093094414342;15150.621234469143;15161.104861892263;4812.23004319309;4913.533214344631;5065.189569668853;5071.543561079502;5098.337216161913;3604.441311596707;3777.508923839897;4996.400431948171;5451.918221226665;5853.151293062503;5801.100829371454;5864.208331875185;5889.234399528055;5908.172855800191;5908.763649454017;5752.798652047159;5821.796237131702;5918.40815918409;5970.641761494324;5973.611715238518;3276.836158192081;4783.689060211075;5080.085584594772;5083.059633967728;5154.149565321755;20177.89021603811;20418.69371959422;20669.17323307081;20906.268280610257;20945;2047.8566500344982;2088.289981406329;2234.821214302852;2273.4657355521604;2389.976100238993;12219.572314968933;12894.161879477804;13039.217646941213;13314.06801523884;13762.65593360164;1742.712452445345;1775.5028591994262;1797.9190936407892;1835.5044138082776;1852.8980906050163;69465.65267173683;70719.29280707179;70722.99999999949;71271.28728712698;71643;15834.841651583567;16505;16701.916490417712;16782.916085419496;16790.74813877793;28767.856160719064;29225.561616575767;29606.259843504085;29725.55411668827;29971;8686.435381700168;8974.86537701935;9062.36563440566;9076.228520575825;9207.63169473227;7606.087269527581;7637.121731001006;7695.653695583712;7829.060512738394;7862.410319226081;8251.711190108317;8345.207205315486;8420;8435.409521333448;8614.569271536398;2677.317284092544;3220.2932445803763;3275.6888095630875;3344.3812894614575;3448.8792892248653;717.3221305866011;767.7005967672612;771.5772474430294;855.8587833007484;895.6399886299517;15888.285027173804;16030.038197708174;16217.756733649005;16426.83573164253;16844.073575953196;832.0847068224904;839.8236370362292;874.7419511244199;905.1310741688053;908.7637214324191;8910.910890891138;9338.673146439842;9358.110979457077;9414.584385615612;9426.434413935185;350556;353072;357629;360734;363517;49405.75297123491;55870;71686.64156679183;80904.59547702225;81453.59273203596;910.0035461170008;942.6747772018642;963.0225321298888;967.4872317671645;971.8785151856018;15146.242687865783;15332;15478.148701821057;15673.921630391775;15863.52409427719;36917;38189.809050954565;39194.41208381819;39344.80327598344;39701.2059758809;47008.29487557621;53068.73465632647;53080.203796943846;53646;54408.455915441926;7886.171951945193;7892.763217103496;7964.068576436593;7967.880481792662;7972.920270797218;8586.527726088574;11621.941890290494;11650.242734222249;12252.203606765532;12482.375881205722;10487.423191724529;10649.787004260026;10711.196660250669;10807.945960270148;10874.565017399533;10352.482375881327;10518.263721539419;10566.154707623218;10646.520906559379;10720.571177153139;10480.633177839045;10739.14086873064;10768.730781730519;10913.690357157191;10962.725931851768;7631.3513351365755;7769.494982826098;7948.443608947318;7950.4832185907735;8021.157778433414;10510.947445262726;10640.095591874777;10645.840312395165;10772.461376930965;10819.242653014213 17:51:40 INFO - PROCESS | 32075 | |3;mootools.html;1200.153891506488;1400.5028214983677;1427.293489722587;1491.3363553218821;1664.5921749171448;6582.111414958979;7290.125184977804;7501.924980750191;7513.549187048781;7746.651400686968;7443.367313778335;7610.200928902468;7618.047744031996;7621.390288776898;7622.237776222375;1830.2404502131599;1889.8204670556345;1891.2718603337746;2161.167950339115;2187.8030977212047;1942.4561122885614;2156.8598041127357;2231.4421394651336;2234.318532847481;2244.898979545916;2179.5422961178174;2197.088208393515;2203;2207.4040009197506;2208.6576580630026;1804.8375646191905;2121.6923546085886;2124.107874692633;2125.3517677108475;2132.562824620949;2103.6528972719484;2180.760116387196;2184.530325979906;2190.452386903274;2195.3194509701884;7898.723544675909;7946.6821327146845;7976.282134607914;7981.760547183594;7989.520628762293;4406.096750166208;4535.455745310584;4537.818487260505;4563.361129441881;4568.817247310104;2684.8657567121763;2718.211718601623;2801.831890086601;2857.8142420742793;2859.5853601227914;834.3617132893341;864.9048604653483;881.9029906710321;886.9822603547957;887.1104547314179;10548.841767373495;10614.946925265323;10664.946675266652;10697.679069627924;10700.946495267552;4262.445882035316;4279.379489973999;4333.566643335705;4380.123975204971;4380.956190438119;9073.863892041625;9101.681441149529;9136.6802161924;9140.405873618194;9142.085791420937;4612.192866248461;4661.627069834473;4662.510436404129;4663.230566956414;4664.836730714409;3643.2349206666368;3752.080740218609;4167;4184.790760462026;4195;3545.7517973742106;3632.4369722693023;3726.459663348799;3730.0861288984374;3736.7944763038295;1114.7826173896012;1123.0341905960868;1128.2215271462665;1129.497373668726;1140.880207578209;760.8554374668795;804.6419343392251;826.5908375354238;826.8677011678103;828.7969447485405;4558.133954548625;4657.441107067174;4681;4734.981978874558;4767.427908650915;843.228445971941;851.51038153061;906.1029580715044;925.1026504290827;936.7143021378408;3293.6212335581713;3323.202431416443;3339.4322965095994;3345.2640419107756;3422.178677117474;9426.481543515172;9514.619415223451;9624.903750962401;9662.613495460102;9697.854532182022;9536.618535258513;9545.093216144454;9557.713268601952;9580.76048098803;9605.663801766905;6379.170707807955;6394.616323020634;6525.3800888915475;6590.7693230736695;6637.336266373421;4714.952850471589;4771.64212684057;4775.283707443911;4791.904161916812;4804.399450068741;8376.916230837614;8426.536540490331;8455.239028487465;8498.02272738643;8530.616122274389;8460.323174145931;8505.872411913702;8761.605727742395;8764.561771911507;9067.818643627223;5992.01131813246;6137.662428566293;6146.754129834757;6728;6893.75871844483;6865.41643960269;6918.5502942308585;7281.453890958093;7547.358474529507;7573.242675732383;6711.530192886451;6868.622225777431;6969.477289203229;7054.858902822018;7082.964585177041;6814.284500127614;6831.760888368884;6915.170179578483;6966.651667416508;6990.335918087773;5813.128030795415;5860.38465961068;5899.941000590111;5910.881782364243;5912.349641539341;4143.606357396043;4161.687873409567;4233.132207897435;4235.661147108162;4243.93634095495;4045.817938192847;4182.075967439708;4242.236397448489;4247.702660813713;4272.636825869711 17:51:40 INFO - PROCESS | 32075 | |4;prototype.html;294.44644069149996;294.8378391884463;298.3391787191371;303.82378220632035;304.1514175450493;4726.763661816908;4755.90488190236;4764.571188593026;4771.689840160388;4778.880527986802;4710.882227944303;4717.481077081527;4724.126036683216;4737.431508219019;4752.477227504972;3484.790912545243;3619.583747868989;3627.437747149183;3653.4337177737493;3654.7025805838944;3562.750607457479;3653;3718.721095917817;3738.2897249522503;3739.2521495700835;3648.7594217965884;3664.59689434162;3677.926441471169;3686.7603605765676;3717.182219911615;3595.2629710909464;3688.6864616507496;3690.5755838078694;3701.7223708221723;3707.6663100320966;3262.1029216965285;3274.4433446314183;3277.8688852445875;3279.1638132276357;3280.2783387654677;4496.2581174106235;4497.212987727167;4507.211238033364;4507.729536227804;4532.342810292489;3985.9202815943518;4158.979205103955;4164.375343698439;4164.68764842638;4237.597428244312;4935.259711043373;4936.703797772109;4940.90118197634;4943.1102401567705;4973;3507.4388097904466;3511.877084302063;3515.9452164350846;3516.1736991806906;3523.1720545671747;5064.82273120439;5147.790269286677;5153;5206.713630750307;5210.609204309692;3536.6737473447456;3537.2748586539697;3542.4155014422845;3549.8580056797955;3561.9492249786376;3577.749557531;3581.2658405026905;3598.136447252693;3598.1544337080763;3602.0814692253307;4095.795210239476;4112.753234805921;4120.835166593362;4153.252414565407;4156.916861662749;4836.968473241177;4864.562189402971;4937.333459982857;4952.430470495867;4964.751762411865;1239.913206075566;1244.4462214314542;1246.2397937258265;1251.2930194440112;1253.3169422664669;766.1878408886598;794.4518282385136;803.3211935914143;809.2756982500629;810.8013536683433;4211.284081706117;4323.870283891489;4395.296752519582;4445.533219012022;4447.08834688888;5089.9745501272255;5108.770105345268;5120.436751957282;5129.435762066169;5130.79476820923;4399.834043978284;4410.095930334273;4421.712588681789;4437.112577484516;4458.576435238647;2634.868256587163;2719.157061311;2731.4567269492672;2733.849638269914;2735.8358498490156;4812.855614331575;4836.516348365206;4841.564259216688;4899.04468628614;4904.828331008398;5095.31213286209;5208.062548741187;5243.449437808975;5266.78932842682;5266.815661451831;4756.6432517561325;4822.807087716522;4843.685160464629;4845.297431872359;4849.539293767087;5056.367954005749;5095.41402738675;5105.4639262878345;5106.897862042664;5110.182370820651;4823;4977.203647416396;5003.899922001467;5061.291419201389;5094.974525127351;4880.78036488366;4896.2410826321975;4899.387576552931;4907.33750943618;4919.2129259318335;3564.946525802063;3577.9284414312087;3598.2443686825013;3599.2441587266967;3608.6391360863704;5135.281060651587;5137.8715532112;5143.434222235626;5151.4590967949325;5154.768035438339;4708.411448568929;4948.579370753526;4954.50454954516;4972.154733695353;5044.243363495359;4918.92621610669;4927.211646136601;4936.358273424432;4939.185034469272;4964.35463389757;4870.366124739484;4904.141775189256;4916.164252077084;4930.802767889244;4961.801527938842;4729.881752956204;4856.980034192859;4863.562279394871;4935.494674124283;4980.961613415741;4855.635827312895;4867.172580661225;4870.586000190024;4894.535019173173;4908.410990681141 17:51:40 INFO - PROCESS | 32075 | |5;yui.html;697.0032853020182;704.8677749806834;727.1601300497924;743.4572761883828;763.194829454925;11867.940660296708;11962.700932476693;12691.301978391184;12922.870771292284;13059.542915997941;12993.1554448961;13039.674008149801;13125.606231813037;13140.60578182656;13147.4083666235;626.4768917953514;766.8236305649676;781.5154604145423;792.9762107136767;794.4240425691386;791.584418180457;791.6912404162381;794.761571528542;794.9006374203225;795.2564352330589;813.7314686153585;814.6008455856647;814.6089876859111;815.2703330519182;815.4169768615438;639.8880195965711;790.9881351779728;806.0126345227109;814.5194335342118;816.9183081691842;594.3224723814855;594.3699678340972;594.5243804956061;594.5897330841706;594.8066878264582;13146.4084116215;13186.340682965909;13188;13192;13211.735765284737;11554.248973816675;11846.644600661994;12141.93929030358;12402.25586464815;12555.309457979807;11378.886211137866;11384;11556.191066625339;11873.287602743776;11988.880111198863;4147.170565886805;4148.743999441121;4171.582841715835;4323.178596066738;4357.041450880801;56116.71941640266;57062;57214.7139264301;57287.71356143193;57631.71184144094;9406.294527910433;9463.195628371666;9531.285153613506;9611.327207095435;9776.21790256792;17409;17466.388676396266;17495.125243737763;17495.562610934827;17496.387626433014;6488.253850807123;6548.377904099103;6594.406503414716;6648.202215734046;6725.192976842713;3517.771344862576;3537.663921927413;3543.75193736436;3616.6021737608844;3621.420572708354;2547;2634.394089359458;2635.3543381871564;3058.571799948009;3183.1882869868036;412.69767333535066;538.8437353167616;546.8304825504107;555.5028249716481;566.7761234312424;428.52433798483656;457.50589363487353;481.95896862776937;489.2172523961704;556.3518500946352;7622.466427350143;7792.337651299589;7829.804254893673;7964.641591128413;8075.838483230303;451.27795527156945;458.7981288233167;494.7921872813427;515.9011305918369;521.0412840373731;3551.5027896094566;3798.848046078126;3822.961770382316;3869.090763670535;3894.6884249259992;53478.7326063375;53542.732286338316;53574.196387054224;53589;83675.16324836796;48518;71267;77081.2291877074;77855;82866.58566707128;70252.29747702662;70730.64634676794;71517.6424117876;74000.62999684968;74184.62907685534;7214.819629509095;7327.596982166032;7350.889736654061;7398.519096258726;7409.740659076906;43027;43339.349909750745;44328;44525.777371112934;45353.54646453625;54219.186712198556;54355.45644543504;55662.44337556572;60739;62142.68928655328;8910.509921954355;8959.283257339528;9005.729828105168;9228.261739060994;9357.625694972125;10053.798924021625;10090.2432317575;10134.087932086148;10168.389896606228;10233.795324093328;8266.45224765373;10373.948130259301;11081.889181108085;11120.777584448104;11206.943965280447;10781.245312828027;11000.449977501254;11073.335599864035;11545.826812597987;11569.363684997406;10490.580376784843;10512.684619461428;10914.72713182145;10941.12471002302;11024.118070554176;9099.454032758056;9288.58201380953;9477.668281610111;9511.476868772284;9627.9037209627;9455.219197322558;9569.521523923915;9621.56702948355;9637.951810240904;9833.459159745997 17:51:40 INFO - PROCESS | 32075 | __end_tp_report 17:51:40 INFO - PROCESS | 32075 | __start_cc_report 17:51:40 INFO - PROCESS | 32075 | _x_x_mozilla_cycle_collect,930 17:51:40 INFO - PROCESS | 32075 | __end_cc_report 17:51:40 INFO - PROCESS | 32075 | __startTimestamp1465433500770__endTimestamp 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | ------- Summary: start ------- 17:51:40 INFO - PROCESS | 32075 | Number of tests: 6 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#0] dojo.html Cycles:165 Average:4629.30 Median:4786.88 stddev:489.55 (10.2%) stddev-sans-first:465.55 17:51:40 INFO - PROCESS | 32075 | Values: 2641.3 2655.7 2672.6 2690.8 2694.5 4500.2 4588.8 4617.4 4666.1 4749.3 4656.7 4670.4 4674.7 4703.2 4717.2 4085.5 4254.1 4338.8 4365.8 4409.3 4323.1 4362.6 4374.1 4380.1 4407.2 4158.6 4196.1 4295.5 4332.5 4339.3 4283.6 4286.6 4300.9 4339.7 4354.9 4287.6 4309.7 4340.6 4381.8 4383.4 4457.2 4521.2 4584.0 4591.6 4605.9 4965.5 5000.6 5005.4 5021.3 5027.5 5037.6 5047.6 5050.2 5057.8 5060.9 4540.9 4614.4 4621.9 4623.2 4666.2 5130.9 5142.8 5154.8 5158.0 5158.3 4784.3 4949.3 4952.1 4964.9 4966.2 4987.3 5026.8 5027.7 5038.5 5046.1 4977.5 4984.4 4993.9 4996.3 5036.6 4840.8 4850.2 4976.7 4980.6 5027.3 4188.2 4193.8 4198.9 4214.5 4233.4 3660.9 3691.7 3695.3 3723.9 3732.1 4142.0 4190.4 4239.8 4245.5 4248.2 4963.9 4992.3 5002.1 5002.7 5049.3 4270.9 4272.2 4275.0 4290.1 4322.8 4367.6 4467.8 4485.8 4489.4 4532.8 4786.9 4806.8 4809.1 4841.4 4854.8 5065.4 5071.3 5080.9 5085.8 5089.7 4597.0 4699.7 4748.6 4761.5 4839.7 4962.4 4973.7 4976.3 4981.8 5011.3 5010.7 5030.3 5039.2 5049.8 5094.7 4753.4 4877.7 4911.9 4932.3 4940.3 4914.8 4950.2 4953.5 4964.3 5012.0 4643.2 4867.1 4874.5 4876.4 4920.7 4875.1 4882.8 4902.8 4913.3 4935.3 4820.8 4830.2 4842.8 4846.1 4897.4 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#1] ext.html Cycles:180 Average:45671.81 Median:35183.06 stddev:85188.32 (242.1%) stddev-sans-first:85360.01 17:51:40 INFO - PROCESS | 32075 | Values: 579.3 586.4 588.6 591.4 602.2 26888.6 29546.7 37748.8 38866.4 39029.0 40038.6 40493.2 40505.2 40521.0 40559.4 7640.8 7772.9 7774.5 7779.7 7782.4 7655.0 7747.9 7748.6 7755.1 7758.3 7755.8 7783.7 7798.2 7803.6 7803.9 7709.0 7756.1 7759.8 7762.4 7768.9 7741.1 7818.9 7827.5 7844.6 7848.5 31873.7 32040.5 32073.0 32085.7 32088.0 3028.1 3045.7 3141.4 3143.0 3169.9 28102.0 28630.3 28998.6 29155.9 30204.2 3000.6 3237.1 3295.9 3345.8 3401.3 197952.0 258891.0 259194.0 259226.0 260673.0 31095.5 54165.5 54945.2 54951.0 54965.5 31887.2 34016.0 34080.8 34104.3 34116.7 13320.3 13597.6 13598.8 13609.7 13612.4 11236.8 11482.3 11483.2 11502.5 11513.7 7882.6 7882.8 7884.8 7939.7 7971.4 3070.5 3078.4 3085.4 3109.2 3151.9 842.3 893.6 895.3 901.2 930.9 27325.7 28027.5 28175.2 28829.3 28887.1 951.9 964.3 974.3 988.8 1032.8 14457.9 14744.4 14753.5 15025.5 15143.4 401143.0 405281.0 405521.0 405704.0 408852.0 49792.8 50474.0 50546.7 50558.7 50608.7 1091.2 1153.9 1226.4 1234.4 1245.2 27991.6 28881.3 29089.6 29198.2 29527.4 40381.4 40418.2 40836.2 40849.0 40850.2 290555.0 293054.0 293184.0 293331.0 294618.0 22613.2 23627.3 24526.5 24679.1 24834.6 41264.4 41278.4 42340.6 42667.4 42771.1 35143.5 35723.3 35989.3 36300.5 36752.4 35153.0 36038.6 36089.0 36474.0 36657.5 35213.1 35547.6 35758.8 36228.6 36319.0 30916.7 31764.7 32279.7 32566.3 32696.0 24776.0 25035.5 25364.2 25445.1 25467.2 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#2] jquery.html Cycles:180 Average:24174.48 Median:374.27 stddev:58956.44 (15752.5%) stddev-sans-first:59094.68 17:51:40 INFO - PROCESS | 32075 | Values: 347.6 348.5 355.4 372.2 376.3 15888.4 16491.2 16988.4 17011.1 17037.7 14393.6 14700.9 15115.1 15150.6 15161.1 4812.2 4913.5 5065.2 5071.5 5098.3 3604.4 3777.5 4996.4 5451.9 5853.2 5801.1 5864.2 5889.2 5908.2 5908.8 5752.8 5821.8 5918.4 5970.6 5973.6 3276.8 4783.7 5080.1 5083.1 5154.1 20177.9 20418.7 20669.2 20906.3 20945.0 2047.9 2088.3 2234.8 2273.5 2390.0 12219.6 12894.2 13039.2 13314.1 13762.7 1742.7 1775.5 1797.9 1835.5 1852.9 69465.7 70719.3 70723.0 71271.3 71643.0 15834.8 16505.0 16701.9 16782.9 16790.7 28767.9 29225.6 29606.3 29725.6 29971.0 8686.4 8974.9 9062.4 9076.2 9207.6 7606.1 7637.1 7695.7 7829.1 7862.4 8251.7 8345.2 8420.0 8435.4 8614.6 2677.3 3220.3 3275.7 3344.4 3448.9 717.3 767.7 771.6 855.9 895.6 15888.3 16030.0 16217.8 16426.8 16844.1 832.1 839.8 874.7 905.1 908.8 8910.9 9338.7 9358.1 9414.6 9426.4 350556.0 353072.0 357629.0 360734.0 363517.0 49405.8 55870.0 71686.6 80904.6 81453.6 910.0 942.7 963.0 967.5 971.9 15146.2 15332.0 15478.1 15673.9 15863.5 36917.0 38189.8 39194.4 39344.8 39701.2 47008.3 53068.7 53080.2 53646.0 54408.5 7886.2 7892.8 7964.1 7967.9 7972.9 8586.5 11621.9 11650.2 12252.2 12482.4 10487.4 10649.8 10711.2 10807.9 10874.6 10352.5 10518.3 10566.2 10646.5 10720.6 10480.6 10739.1 10768.7 10913.7 10962.7 7631.4 7769.5 7948.4 7950.5 8021.2 10510.9 10640.1 10645.8 10772.5 10819.2 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#3] mootools.html Cycles:180 Average:4990.73 Median:4769.54 stddev:2839.64 (59.5%) stddev-sans-first:2833.31 17:51:40 INFO - PROCESS | 32075 | Values: 1200.2 1400.5 1427.3 1491.3 1664.6 6582.1 7290.1 7501.9 7513.5 7746.7 7443.4 7610.2 7618.0 7621.4 7622.2 1830.2 1889.8 1891.3 2161.2 2187.8 1942.5 2156.9 2231.4 2234.3 2244.9 2179.5 2197.1 2203.0 2207.4 2208.7 1804.8 2121.7 2124.1 2125.4 2132.6 2103.7 2180.8 2184.5 2190.5 2195.3 7898.7 7946.7 7976.3 7981.8 7989.5 4406.1 4535.5 4537.8 4563.4 4568.8 2684.9 2718.2 2801.8 2857.8 2859.6 834.4 864.9 881.9 887.0 887.1 10548.8 10614.9 10664.9 10697.7 10700.9 4262.4 4279.4 4333.6 4380.1 4381.0 9073.9 9101.7 9136.7 9140.4 9142.1 4612.2 4661.6 4662.5 4663.2 4664.8 3643.2 3752.1 4167.0 4184.8 4195.0 3545.8 3632.4 3726.5 3730.1 3736.8 1114.8 1123.0 1128.2 1129.5 1140.9 760.9 804.6 826.6 826.9 828.8 4558.1 4657.4 4681.0 4735.0 4767.4 843.2 851.5 906.1 925.1 936.7 3293.6 3323.2 3339.4 3345.3 3422.2 9426.5 9514.6 9624.9 9662.6 9697.9 9536.6 9545.1 9557.7 9580.8 9605.7 6379.2 6394.6 6525.4 6590.8 6637.3 4715.0 4771.6 4775.3 4791.9 4804.4 8376.9 8426.5 8455.2 8498.0 8530.6 8460.3 8505.9 8761.6 8764.6 9067.8 5992.0 6137.7 6146.8 6728.0 6893.8 6865.4 6918.6 7281.5 7547.4 7573.2 6711.5 6868.6 6969.5 7054.9 7083.0 6814.3 6831.8 6915.2 6966.7 6990.3 5813.1 5860.4 5899.9 5910.9 5912.3 4143.6 4161.7 4233.1 4235.7 4243.9 4045.8 4182.1 4242.2 4247.7 4272.6 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#4] prototype.html Cycles:180 Average:4110.16 Median:4733.66 stddev:1204.43 (25.4%) stddev-sans-first:1173.26 17:51:40 INFO - PROCESS | 32075 | Values: 294.4 294.8 298.3 303.8 304.2 4726.8 4755.9 4764.6 4771.7 4778.9 4710.9 4717.5 4724.1 4737.4 4752.5 3484.8 3619.6 3627.4 3653.4 3654.7 3562.8 3653.0 3718.7 3738.3 3739.3 3648.8 3664.6 3677.9 3686.8 3717.2 3595.3 3688.7 3690.6 3701.7 3707.7 3262.1 3274.4 3277.9 3279.2 3280.3 4496.3 4497.2 4507.2 4507.7 4532.3 3985.9 4159.0 4164.4 4164.7 4237.6 4935.3 4936.7 4940.9 4943.1 4973.0 3507.4 3511.9 3515.9 3516.2 3523.2 5064.8 5147.8 5153.0 5206.7 5210.6 3536.7 3537.3 3542.4 3549.9 3561.9 3577.7 3581.3 3598.1 3598.2 3602.1 4095.8 4112.8 4120.8 4153.3 4156.9 4837.0 4864.6 4937.3 4952.4 4964.8 1239.9 1244.4 1246.2 1251.3 1253.3 766.2 794.5 803.3 809.3 810.8 4211.3 4323.9 4395.3 4445.5 4447.1 5090.0 5108.8 5120.4 5129.4 5130.8 4399.8 4410.1 4421.7 4437.1 4458.6 2634.9 2719.2 2731.5 2733.8 2735.8 4812.9 4836.5 4841.6 4899.0 4904.8 5095.3 5208.1 5243.4 5266.8 5266.8 4756.6 4822.8 4843.7 4845.3 4849.5 5056.4 5095.4 5105.5 5106.9 5110.2 4823.0 4977.2 5003.9 5061.3 5095.0 4880.8 4896.2 4899.4 4907.3 4919.2 3564.9 3577.9 3598.2 3599.2 3608.6 5135.3 5137.9 5143.4 5151.5 5154.8 4708.4 4948.6 4954.5 4972.2 5044.2 4918.9 4927.2 4936.4 4939.2 4964.4 4870.4 4904.1 4916.2 4930.8 4961.8 4729.9 4857.0 4863.6 4935.5 4981.0 4855.6 4867.2 4870.6 4894.5 4908.4 17:51:40 INFO - PROCESS | 32075 | 17:51:40 INFO - PROCESS | 32075 | [#5] yui.html Cycles:180 Average:15670.79 Median:54287.32 stddev:21105.40 (38.9%) stddev-sans-first:21134.65 17:51:40 INFO - PROCESS | 32075 | Values: 697.0 704.9 727.2 743.5 763.2 11867.9 11962.7 12691.3 12922.9 13059.5 12993.2 13039.7 13125.6 13140.6 13147.4 626.5 766.8 781.5 793.0 794.4 791.6 791.7 794.8 794.9 795.3 813.7 814.6 814.6 815.3 815.4 639.9 791.0 806.0 814.5 816.9 594.3 594.4 594.5 594.6 594.8 13146.4 13186.3 13188.0 13192.0 13211.7 11554.2 11846.6 12141.9 12402.3 12555.3 11378.9 11384.0 11556.2 11873.3 11988.9 4147.2 4148.7 4171.6 4323.2 4357.0 56116.7 57062.0 57214.7 57287.7 57631.7 9406.3 9463.2 9531.3 9611.3 9776.2 17409.0 17466.4 17495.1 17495.6 17496.4 6488.3 6548.4 6594.4 6648.2 6725.2 3517.8 3537.7 3543.8 3616.6 3621.4 2547.0 2634.4 2635.4 3058.6 3183.2 412.7 538.8 546.8 555.5 566.8 428.5 457.5 482.0 489.2 556.4 7622.5 7792.3 7829.8 7964.6 8075.8 451.3 458.8 494.8 515.9 521.0 3551.5 3798.8 3823.0 3869.1 3894.7 53478.7 53542.7 53574.2 53589.0 83675.2 48518.0 71267.0 77081.2 77855.0 82866.6 70252.3 70730.6 71517.6 74000.6 74184.6 7214.8 7327.6 7350.9 7398.5 7409.7 43027.0 43339.3 44328.0 44525.8 45353.5 54219.2 54355.5 55662.4 60739.0 62142.7 8910.5 8959.3 9005.7 9228.3 9357.6 10053.8 10090.2 10134.1 10168.4 10233.8 8266.5 10373.9 11081.9 11120.8 11206.9 10781.2 11000.4 11073.3 11545.8 11569.4 10490.6 10512.7 10914.7 10941.1 11024.1 9099.5 9288.6 9477.7 9511.5 9627.9 9455.2 9569.5 9621.6 9638.0 9833.5 17:51:40 INFO - PROCESS | 32075 | -------- Summary: end -------- 17:51:40 INFO - PROCESS | 32075 | 17:51:41 INFO - TEST-INFO | 32075: exit 0 17:51:41 INFO - TEST-OK | dromaeo_css | took 1119505ms 17:51:41 INFO - TEST-START | kraken 17:51:41 INFO - operating with platform_type : linux_ 17:51:41 INFO - Initialising browser for kraken test... 17:51:41 INFO - TEST-INFO | started process 32257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQFB9s/profile http://localhost:46465/getInfo.html) 17:51:45 INFO - PROCESS | 32257 | __metrics Screen width/height:1600/1200 17:51:45 INFO - PROCESS | 32257 | colorDepth:24 17:51:45 INFO - PROCESS | 32257 | Browser inner width/height: 1024/697 17:51:45 INFO - PROCESS | 32257 | __metrics 17:51:46 ERROR - PROCESS | 32257 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:51:47 INFO - PROCESS | 32257 | console.error: PushService: 17:51:47 INFO - PROCESS | 32257 | stateChangeProcessEnqueue: Error transitioning state 17:51:47 INFO - PROCESS | 32257 | UnknownError 17:51:47 INFO - TEST-INFO | 32257: exit 0 17:51:47 INFO - Browser initialized. 17:51:47 INFO - Running cycle 1/1 for kraken test... 17:51:47 INFO - TEST-INFO | started process 32340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQFB9s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:59 INFO - PROCESS | 32340 | RSS: Main: 157728768 17:51:59 INFO - PROCESS | 32340 | 17:52:02 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46465/tests/kraken/driver.html?testName=audio-beat-detection) 17:52:03 INFO - PROCESS | 32340 | RSS: Main: 215691264 17:52:03 INFO - PROCESS | 32340 | 17:52:06 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46465/tests/kraken/driver.html?testName=audio-dft) 17:52:07 INFO - PROCESS | 32340 | RSS: Main: 203083776 17:52:07 INFO - PROCESS | 32340 | 17:52:10 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46465/tests/kraken/driver.html?testName=audio-fft) 17:52:10 INFO - PROCESS | 32340 | RSS: Main: 270311424 17:52:10 INFO - PROCESS | 32340 | 17:52:13 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46465/tests/kraken/driver.html?testName=audio-oscillator) 17:52:13 INFO - PROCESS | 32340 | RSS: Main: 180203520 17:52:13 INFO - PROCESS | 32340 | 17:52:15 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:16 INFO - PROCESS | 32340 | RSS: Main: 184406016 17:52:16 INFO - PROCESS | 32340 | 17:52:19 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46465/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:20 INFO - PROCESS | 32340 | RSS: Main: 220626944 17:52:20 INFO - PROCESS | 32340 | 17:52:23 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46465/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:24 INFO - PROCESS | 32340 | RSS: Main: 216133632 17:52:24 INFO - PROCESS | 32340 | 17:52:27 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46465/tests/kraken/driver.html?testName=json-parse-financial) 17:52:27 INFO - PROCESS | 32340 | RSS: Main: 219291648 17:52:27 INFO - PROCESS | 32340 | 17:52:29 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:30 INFO - PROCESS | 32340 | RSS: Main: 209268736 17:52:30 INFO - PROCESS | 32340 | 17:52:32 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:32 INFO - PROCESS | 32340 | RSS: Main: 211832832 17:52:32 INFO - PROCESS | 32340 | 17:52:34 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:35 INFO - PROCESS | 32340 | RSS: Main: 216707072 17:52:35 INFO - PROCESS | 32340 | 17:52:38 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:39 INFO - PROCESS | 32340 | RSS: Main: 224399360 17:52:39 INFO - PROCESS | 32340 | 17:52:41 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:42 INFO - PROCESS | 32340 | RSS: Main: 224481280 17:52:42 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | Cycle 1(1): loaded http://localhost:46465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46465/tests/kraken/driver.html?testName=ai-astar) 17:52:44 INFO - PROCESS | 32340 | RSS: Main: 266944512 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | __start_tp_report 17:52:44 INFO - PROCESS | 32340 | _x_x_mozilla_page_load 17:52:44 INFO - PROCESS | 32340 | _x_x_mozilla_page_load_details 17:52:44 INFO - PROCESS | 32340 | |i|pagename|runs| 17:52:44 INFO - PROCESS | 32340 | |0;ai-astar;116;109;113;114;113;116;113;112;114;112 17:52:44 INFO - PROCESS | 32340 | |1;audio-beat-detection;156;139;132;188;129;133;155;132;206;130 17:52:44 INFO - PROCESS | 32340 | |2;audio-dft;163;160;161;164;162;161;164;161;162;161 17:52:44 INFO - PROCESS | 32340 | |3;audio-fft;77;74;76;112;76;77;75;74;98;74 17:52:44 INFO - PROCESS | 32340 | |4;audio-oscillator;86;87;120;87;93;86;119;85;87;132 17:52:44 INFO - PROCESS | 32340 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 17:52:44 INFO - PROCESS | 32340 | |6;imaging-darkroom;147;146;146;147;147;147;145;146;145;146 17:52:44 INFO - PROCESS | 32340 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 17:52:44 INFO - PROCESS | 32340 | |8;json-parse-financial;70;64;65;63;64;64;64;63;63;63 17:52:44 INFO - PROCESS | 32340 | |9;json-stringify-tinderbox;65;66;65;65;66;66;65;66;66;67 17:52:44 INFO - PROCESS | 32340 | |10;stanford-crypto-aes;85;83;83;84;84;85;85;85;122;85 17:52:44 INFO - PROCESS | 32340 | |11;stanford-crypto-ccm;137;142;132;143;129;145;141;132;137;134 17:52:44 INFO - PROCESS | 32340 | |12;stanford-crypto-pbkdf2;172;174;172;171;169;174;170;169;174;167 17:52:44 INFO - PROCESS | 32340 | |13;stanford-crypto-sha256-iterative;68;67;67;67;70;71;71;65;68;67 17:52:44 INFO - PROCESS | 32340 | __end_tp_report 17:52:44 INFO - PROCESS | 32340 | __start_cc_report 17:52:44 INFO - PROCESS | 32340 | _x_x_mozilla_cycle_collect,1905 17:52:44 INFO - PROCESS | 32340 | __end_cc_report 17:52:44 INFO - PROCESS | 32340 | __startTimestamp1465433564580__endTimestamp 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | ------- Summary: start ------- 17:52:44 INFO - PROCESS | 32340 | Number of tests: 14 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:2.04 (1.8%) stddev-sans-first:1.90 17:52:44 INFO - PROCESS | 32340 | Values: 116.0 109.0 113.0 114.0 113.0 116.0 113.0 112.0 114.0 112.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:147.00 stddev:26.96 (18.3%) stddev-sans-first:28.50 17:52:44 INFO - PROCESS | 32340 | Values: 156.0 139.0 132.0 188.0 129.0 133.0 155.0 132.0 206.0 130.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.39 17:52:44 INFO - PROCESS | 32340 | Values: 163.0 160.0 161.0 164.0 162.0 161.0 164.0 161.0 162.0 161.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.97 (17.1%) stddev-sans-first:13.66 17:52:44 INFO - PROCESS | 32340 | Values: 77.0 74.0 76.0 112.0 76.0 77.0 75.0 74.0 98.0 74.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:86.50 stddev:18.03 (20.8%) stddev-sans-first:18.57 17:52:44 INFO - PROCESS | 32340 | Values: 86.0 87.0 120.0 87.0 93.0 86.0 119.0 85.0 87.0 132.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:52:44 INFO - PROCESS | 32340 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:52:44 INFO - PROCESS | 32340 | Values: 147.0 146.0 146.0 147.0 147.0 147.0 145.0 146.0 145.0 146.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:52:44 INFO - PROCESS | 32340 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:2.11 (3.3%) stddev-sans-first:0.71 17:52:44 INFO - PROCESS | 32340 | Values: 70.0 64.0 65.0 63.0 64.0 64.0 64.0 63.0 63.0 63.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:52:44 INFO - PROCESS | 32340 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 65.0 66.0 66.0 67.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:85.00 stddev:11.94 (14.0%) stddev-sans-first:12.61 17:52:44 INFO - PROCESS | 32340 | Values: 85.0 83.0 83.0 84.0 84.0 85.0 85.0 85.0 122.0 85.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:139.00 stddev:5.41 (3.9%) stddev-sans-first:5.74 17:52:44 INFO - PROCESS | 32340 | Values: 137.0 142.0 132.0 143.0 129.0 145.0 141.0 132.0 137.0 134.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:2.44 (1.4%) stddev-sans-first:2.57 17:52:44 INFO - PROCESS | 32340 | Values: 172.0 174.0 172.0 171.0 169.0 174.0 170.0 169.0 174.0 167.0 17:52:44 INFO - PROCESS | 32340 | 17:52:44 INFO - PROCESS | 32340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.97 (2.9%) stddev-sans-first:2.09 17:52:44 INFO - PROCESS | 32340 | Values: 68.0 67.0 67.0 67.0 70.0 71.0 71.0 65.0 68.0 67.0 17:52:44 INFO - PROCESS | 32340 | -------- Summary: end -------- 17:52:44 INFO - PROCESS | 32340 | 17:52:45 INFO - TEST-INFO | 32340: exit 0 17:52:45 INFO - TEST-OK | kraken | took 64115ms 17:52:45 INFO - SUITE-END | took 1183s 17:52:45 INFO - Completed test suite (00:19:43) 17:52:45 INFO - javascript benchmark 17:52:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.3000554852965, 2655.668041494813, 2672.5590277604197, 2690.771284440821, 2694.5419278722616, 4500.23496005679, 4588.7935042923145, 4617.445906491217, 4666.136764698533, 4749.263864101065, 4656.697314674552, 4670.369500117483, 4674.672772905898, 4703.200455922492, 4717.150912835688, 4085.468889044435, 4254.127903779726, 4338.84814031509, 4365.781710914457, 4409.250427427329, 4323.1353729254115, 4362.563743625644, 4374.103308821684, 4380.08018316154, 4407.206702793496, 4158.604932531404, 4196.139791342767, 4295.463067116611, 4332.545082766295, 4339.349097635349, 4283.550227226127, 4286.57134286572, 4300.913981720348, 4339.652827773771, 4354.869353919387, 4287.635550978171, 4309.719868208556, 4340.587644173798, 4381.78091095444, 4383.430154079949, 4457.24226881431, 4521.163584736834, 4583.9541604583865, 4591.563801438858, 4605.884852878671, 4965.453800081988, 5000.649954503187, 5005.374328208974, 5021.271915572222, 5027.547520723116, 5037.647364684473, 5047.596192304607, 5050.166722490784, 5057.822976195852, 5060.924086138711, 4540.8637740867825, 4614.446266448048, 4621.907561848811, 4623.190941585209, 4666.183417901853, 5130.948690513122, 5142.794288228504, 5154.845354639292, 5158.0199762045095, 5158.303629010035, 4784.30627559002, 4949.257611358325, 4952.108620448354, 4964.925526117111, 4966.15575352191, 4987.251912213124, 5026.824061157842, 5027.723475208899, 5038.496150385005, 5046.091703493406, 4977.527134922177, 4984.4267909190185, 4993.925091123636, 4996.2505624156665, 5036.597072234213, 4840.806367745321, 4850.151223535867, 4976.726280054631, 4980.601551875841, 5027.321311622884, 4188.246115699142, 4193.769342686121, 4198.895027624334, 4214.536400995888, 4233.449651545279, 3660.926781464356, 3691.7231207659534, 3695.2609478104487, 3723.906902327409, 3732.141607430306, 4141.97929010353, 4190.413342132104, 4239.8092085856215, 4245.490541135084, 4248.150369926027, 4963.875903102451, 4992.2511623256805, 5002.099622068063, 5002.674826136289, 5049.318342023853, 4270.871873843789, 4272.166927449118, 4275.0381164238415, 4290.099079193405, 4322.783860806947, 4367.62875155609, 4467.776611169428, 4485.798139083749, 4489.438820147481, 4532.841350552715, 4786.880327991828, 4806.831760888352, 4809.062232864558, 4841.419029716457, 4854.80580776765, 5065.442801291929, 5071.315372424676, 5080.923786143285, 5085.77114029877, 5089.720065396439, 4596.954030459653, 4699.671023028355, 4748.62011039123, 4761.547652972962, 4839.733814640229, 4962.42932062803, 4973.726445045412, 4976.30331753562, 4981.800727970841, 5011.323471331323, 5010.674306170087, 5030.346055012825, 5039.168537191323, 5049.798008079636, 5094.745262736774, 4753.382060332135, 4877.707337559757, 4911.901761964812, 4932.260160975882, 4940.258961155855, 4914.803407863646, 4950.183219768842, 4953.504649535162, 4964.3298154748645, 5012.04771093491, 4643.210654188729, 4867.099586576494, 4874.488178741181, 4876.439209490812, 4920.655554111321, 4875.146849301287, 4882.804687812448, 4902.803887844446, 4913.263010548446, 4935.333729946555, 4820.783064762164, 4830.227163653799, 4842.7578621068105, 4846.055019271208, 4897.36334276556], "value": 4598.4115030004605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.339552909683, 586.4399498478953, 588.5879884081145, 591.3642833953498, 602.1599868183882, 26888.59667104995, 29546.704532954693, 37748.81125594375, 38866.417003744966, 39029.0, 40038.59961400385, 40493.190136197256, 40505.18989620206, 40521.0, 40559.39160912589, 7640.847183056336, 7772.922270777276, 7774.455788094836, 7779.716346802771, 7782.416318776114, 7654.961725191394, 7747.922520774777, 7748.6125693715085, 7755.069391673007, 7758.262965018314, 7755.844883102334, 7783.727569535067, 7798.220177982184, 7803.5708036057995, 7803.921960780404, 7709.0, 7756.146823849372, 7759.8448031039625, 7762.37900967924, 7768.883466748003, 7741.071071471403, 7818.8827167592535, 7827.491213071132, 7844.646990885424, 7848.529088254723, 31873.681263187304, 32040.519392209135, 32073.0, 32085.6791432085, 32088.0, 3028.1369809604375, 3045.6954304569585, 3141.387429451258, 3142.9685703142904, 3169.9366012679848, 28102.0, 28630.284242893886, 28998.588165357913, 29155.854220728972, 30204.24489387761, 3000.6249218847643, 3237.14215732831, 3295.9011229663147, 3345.8159801210923, 3401.3197360527993, 197952.0, 258891.0, 259194.0, 259226.0, 260673.0, 31095.533566996513, 54165.45834541683, 54945.1758223627, 54951.0, 54965.450345496836, 31887.202819929687, 34015.97952061442, 34080.829595851865, 34104.317913641586, 34116.65883341184, 13320.267385293708, 13597.592072237849, 13598.796018059737, 13609.727805444034, 13612.387442565108, 11236.83144752813, 11482.311061336346, 11483.196176267582, 11502.539898404137, 11513.712157196138, 7882.645280962371, 7882.846861255543, 7884.802879928047, 7939.722109726132, 7971.40214483916, 3070.462669032955, 3078.415101130778, 3085.4291955988215, 3109.2382366319944, 3151.9212019699235, 842.2924743215729, 893.6023469555985, 895.3329769321766, 901.1619194149373, 930.916217540411, 27325.726742732717, 28027.546777546893, 28175.15474535767, 28829.279268018046, 28887.133385998455, 951.8952915179325, 964.320154291223, 974.3206182996759, 988.7824678570703, 1032.8192566300868, 14457.85542144565, 14744.410223590936, 14753.483628072965, 15025.549233523012, 15143.394264229528, 401143.0, 405281.0, 405521.0, 405704.0, 408852.0, 49792.75103624459, 50474.0, 50546.74726626343, 50558.74720626447, 50608.746956264986, 1091.165258577189, 1153.8903804138592, 1226.405193481161, 1234.4383305595932, 1245.1968480330136, 27991.58012629853, 28881.277968050967, 29089.563656545593, 29198.195903322197, 29527.409451811272, 40381.394279086424, 40418.19163616652, 40836.1832763349, 40849.0, 40850.1829963405, 290555.0, 293054.0, 293184.0, 293331.0, 294618.0, 22613.20853770176, 23627.29118126459, 24526.509469810862, 24679.136230231856, 24834.627480588166, 41264.381034285114, 41278.38082428706, 42340.576594233666, 42667.3599896008, 42771.144577108906, 35143.47284790781, 35723.28553428969, 35989.28021439609, 36300.455493167094, 36752.44871326879, 35153.0, 36038.639613603526, 36089.0, 36474.0, 36657.45013824741, 35213.119672008404, 35547.64452355443, 35758.8212058938, 36228.63771362253, 36319.0, 30916.690833091383, 31764.682353176173, 32279.677203227668, 32566.34867302688, 32696.0, 24776.0, 25035.49929001446, 25364.239394824777, 25445.10942117017, 25467.23598292054], "value": 16268.007814181146, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.5957133181943, 348.49816264579005, 355.4419561288777, 372.19419955795706, 376.3414025455453, 15888.364465421384, 16491.175441227937, 16988.405405810798, 17011.149442527854, 17037.7444338335, 14393.64015899603, 14700.926495367536, 15115.093094414342, 15150.621234469143, 15161.104861892263, 4812.23004319309, 4913.533214344631, 5065.189569668853, 5071.543561079502, 5098.337216161913, 3604.441311596707, 3777.508923839897, 4996.400431948171, 5451.918221226665, 5853.151293062503, 5801.100829371454, 5864.208331875185, 5889.234399528055, 5908.172855800191, 5908.763649454017, 5752.798652047159, 5821.796237131702, 5918.40815918409, 5970.641761494324, 5973.611715238518, 3276.836158192081, 4783.689060211075, 5080.085584594772, 5083.059633967728, 5154.149565321755, 20177.89021603811, 20418.69371959422, 20669.17323307081, 20906.268280610257, 20945.0, 2047.8566500344982, 2088.289981406329, 2234.821214302852, 2273.4657355521604, 2389.976100238993, 12219.572314968933, 12894.161879477804, 13039.217646941213, 13314.06801523884, 13762.65593360164, 1742.712452445345, 1775.5028591994262, 1797.9190936407892, 1835.5044138082776, 1852.8980906050163, 69465.65267173683, 70719.29280707179, 70722.99999999949, 71271.28728712698, 71643.0, 15834.841651583567, 16505.0, 16701.916490417712, 16782.916085419496, 16790.74813877793, 28767.856160719064, 29225.561616575767, 29606.259843504085, 29725.55411668827, 29971.0, 8686.435381700168, 8974.86537701935, 9062.36563440566, 9076.228520575825, 9207.63169473227, 7606.087269527581, 7637.121731001006, 7695.653695583712, 7829.060512738394, 7862.410319226081, 8251.711190108317, 8345.207205315486, 8420.0, 8435.409521333448, 8614.569271536398, 2677.317284092544, 3220.2932445803763, 3275.6888095630875, 3344.3812894614575, 3448.8792892248653, 717.3221305866011, 767.7005967672612, 771.5772474430294, 855.8587833007484, 895.6399886299517, 15888.285027173804, 16030.038197708174, 16217.756733649005, 16426.83573164253, 16844.073575953196, 832.0847068224904, 839.8236370362292, 874.7419511244199, 905.1310741688053, 908.7637214324191, 8910.910890891138, 9338.673146439842, 9358.110979457077, 9414.584385615612, 9426.434413935185, 350556.0, 353072.0, 357629.0, 360734.0, 363517.0, 49405.75297123491, 55870.0, 71686.64156679183, 80904.59547702225, 81453.59273203596, 910.0035461170008, 942.6747772018642, 963.0225321298888, 967.4872317671645, 971.8785151856018, 15146.242687865783, 15332.0, 15478.148701821057, 15673.921630391775, 15863.52409427719, 36917.0, 38189.809050954565, 39194.41208381819, 39344.80327598344, 39701.2059758809, 47008.29487557621, 53068.73465632647, 53080.203796943846, 53646.0, 54408.455915441926, 7886.171951945193, 7892.763217103496, 7964.068576436593, 7967.880481792662, 7972.920270797218, 8586.527726088574, 11621.941890290494, 11650.242734222249, 12252.203606765532, 12482.375881205722, 10487.423191724529, 10649.787004260026, 10711.196660250669, 10807.945960270148, 10874.565017399533, 10352.482375881327, 10518.263721539419, 10566.154707623218, 10646.520906559379, 10720.571177153139, 10480.633177839045, 10739.14086873064, 10768.730781730519, 10913.690357157191, 10962.725931851768, 7631.3513351365755, 7769.494982826098, 7948.443608947318, 7950.4832185907735, 8021.157778433414, 10510.947445262726, 10640.095591874777, 10645.840312395165, 10772.461376930965, 10819.242653014213], "value": 8924.252703040396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.153891506488, 1400.5028214983677, 1427.293489722587, 1491.3363553218821, 1664.5921749171448, 6582.111414958979, 7290.125184977804, 7501.924980750191, 7513.549187048781, 7746.651400686968, 7443.367313778335, 7610.200928902468, 7618.047744031996, 7621.390288776898, 7622.237776222375, 1830.2404502131599, 1889.8204670556345, 1891.2718603337746, 2161.167950339115, 2187.8030977212047, 1942.4561122885614, 2156.8598041127357, 2231.4421394651336, 2234.318532847481, 2244.898979545916, 2179.5422961178174, 2197.088208393515, 2203.0, 2207.4040009197506, 2208.6576580630026, 1804.8375646191905, 2121.6923546085886, 2124.107874692633, 2125.3517677108475, 2132.562824620949, 2103.6528972719484, 2180.760116387196, 2184.530325979906, 2190.452386903274, 2195.3194509701884, 7898.723544675909, 7946.6821327146845, 7976.282134607914, 7981.760547183594, 7989.520628762293, 4406.096750166208, 4535.455745310584, 4537.818487260505, 4563.361129441881, 4568.817247310104, 2684.8657567121763, 2718.211718601623, 2801.831890086601, 2857.8142420742793, 2859.5853601227914, 834.3617132893341, 864.9048604653483, 881.9029906710321, 886.9822603547957, 887.1104547314179, 10548.841767373495, 10614.946925265323, 10664.946675266652, 10697.679069627924, 10700.946495267552, 4262.445882035316, 4279.379489973999, 4333.566643335705, 4380.123975204971, 4380.956190438119, 9073.863892041625, 9101.681441149529, 9136.6802161924, 9140.405873618194, 9142.085791420937, 4612.192866248461, 4661.627069834473, 4662.510436404129, 4663.230566956414, 4664.836730714409, 3643.2349206666368, 3752.080740218609, 4167.0, 4184.790760462026, 4195.0, 3545.7517973742106, 3632.4369722693023, 3726.459663348799, 3730.0861288984374, 3736.7944763038295, 1114.7826173896012, 1123.0341905960868, 1128.2215271462665, 1129.497373668726, 1140.880207578209, 760.8554374668795, 804.6419343392251, 826.5908375354238, 826.8677011678103, 828.7969447485405, 4558.133954548625, 4657.441107067174, 4681.0, 4734.981978874558, 4767.427908650915, 843.228445971941, 851.51038153061, 906.1029580715044, 925.1026504290827, 936.7143021378408, 3293.6212335581713, 3323.202431416443, 3339.4322965095994, 3345.2640419107756, 3422.178677117474, 9426.481543515172, 9514.619415223451, 9624.903750962401, 9662.613495460102, 9697.854532182022, 9536.618535258513, 9545.093216144454, 9557.713268601952, 9580.76048098803, 9605.663801766905, 6379.170707807955, 6394.616323020634, 6525.3800888915475, 6590.7693230736695, 6637.336266373421, 4714.952850471589, 4771.64212684057, 4775.283707443911, 4791.904161916812, 4804.399450068741, 8376.916230837614, 8426.536540490331, 8455.239028487465, 8498.02272738643, 8530.616122274389, 8460.323174145931, 8505.872411913702, 8761.605727742395, 8764.561771911507, 9067.818643627223, 5992.01131813246, 6137.662428566293, 6146.754129834757, 6728.0, 6893.75871844483, 6865.41643960269, 6918.5502942308585, 7281.453890958093, 7547.358474529507, 7573.242675732383, 6711.530192886451, 6868.622225777431, 6969.477289203229, 7054.858902822018, 7082.964585177041, 6814.284500127614, 6831.760888368884, 6915.170179578483, 6966.651667416508, 6990.335918087773, 5813.128030795415, 5860.38465961068, 5899.941000590111, 5910.881782364243, 5912.349641539341, 4143.606357396043, 4161.687873409567, 4233.132207897435, 4235.661147108162, 4243.93634095495, 4045.817938192847, 4182.075967439708, 4242.236397448489, 4247.702660813713, 4272.636825869711], "value": 4010.863187884822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.44644069149996, 294.8378391884463, 298.3391787191371, 303.82378220632035, 304.1514175450493, 4726.763661816908, 4755.90488190236, 4764.571188593026, 4771.689840160388, 4778.880527986802, 4710.882227944303, 4717.481077081527, 4724.126036683216, 4737.431508219019, 4752.477227504972, 3484.790912545243, 3619.583747868989, 3627.437747149183, 3653.4337177737493, 3654.7025805838944, 3562.750607457479, 3653.0, 3718.721095917817, 3738.2897249522503, 3739.2521495700835, 3648.7594217965884, 3664.59689434162, 3677.926441471169, 3686.7603605765676, 3717.182219911615, 3595.2629710909464, 3688.6864616507496, 3690.5755838078694, 3701.7223708221723, 3707.6663100320966, 3262.1029216965285, 3274.4433446314183, 3277.8688852445875, 3279.1638132276357, 3280.2783387654677, 4496.2581174106235, 4497.212987727167, 4507.211238033364, 4507.729536227804, 4532.342810292489, 3985.9202815943518, 4158.979205103955, 4164.375343698439, 4164.68764842638, 4237.597428244312, 4935.259711043373, 4936.703797772109, 4940.90118197634, 4943.1102401567705, 4973.0, 3507.4388097904466, 3511.877084302063, 3515.9452164350846, 3516.1736991806906, 3523.1720545671747, 5064.82273120439, 5147.790269286677, 5153.0, 5206.713630750307, 5210.609204309692, 3536.6737473447456, 3537.2748586539697, 3542.4155014422845, 3549.8580056797955, 3561.9492249786376, 3577.749557531, 3581.2658405026905, 3598.136447252693, 3598.1544337080763, 3602.0814692253307, 4095.795210239476, 4112.753234805921, 4120.835166593362, 4153.252414565407, 4156.916861662749, 4836.968473241177, 4864.562189402971, 4937.333459982857, 4952.430470495867, 4964.751762411865, 1239.913206075566, 1244.4462214314542, 1246.2397937258265, 1251.2930194440112, 1253.3169422664669, 766.1878408886598, 794.4518282385136, 803.3211935914143, 809.2756982500629, 810.8013536683433, 4211.284081706117, 4323.870283891489, 4395.296752519582, 4445.533219012022, 4447.08834688888, 5089.9745501272255, 5108.770105345268, 5120.436751957282, 5129.435762066169, 5130.79476820923, 4399.834043978284, 4410.095930334273, 4421.712588681789, 4437.112577484516, 4458.576435238647, 2634.868256587163, 2719.157061311, 2731.4567269492672, 2733.849638269914, 2735.8358498490156, 4812.855614331575, 4836.516348365206, 4841.564259216688, 4899.04468628614, 4904.828331008398, 5095.31213286209, 5208.062548741187, 5243.449437808975, 5266.78932842682, 5266.815661451831, 4756.6432517561325, 4822.807087716522, 4843.685160464629, 4845.297431872359, 4849.539293767087, 5056.367954005749, 5095.41402738675, 5105.4639262878345, 5106.897862042664, 5110.182370820651, 4823.0, 4977.203647416396, 5003.899922001467, 5061.291419201389, 5094.974525127351, 4880.78036488366, 4896.2410826321975, 4899.387576552931, 4907.33750943618, 4919.2129259318335, 3564.946525802063, 3577.9284414312087, 3598.2443686825013, 3599.2441587266967, 3608.6391360863704, 5135.281060651587, 5137.8715532112, 5143.434222235626, 5151.4590967949325, 5154.768035438339, 4708.411448568929, 4948.579370753526, 4954.50454954516, 4972.154733695353, 5044.243363495359, 4918.92621610669, 4927.211646136601, 4936.358273424432, 4939.185034469272, 4964.35463389757, 4870.366124739484, 4904.141775189256, 4916.164252077084, 4930.802767889244, 4961.801527938842, 4729.881752956204, 4856.980034192859, 4863.562279394871, 4935.494674124283, 4980.961613415741, 4855.635827312895, 4867.172580661225, 4870.586000190024, 4894.535019173173, 4908.410990681141], "value": 3725.672302951938, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.0032853020182, 704.8677749806834, 727.1601300497924, 743.4572761883828, 763.194829454925, 11867.940660296708, 11962.700932476693, 12691.301978391184, 12922.870771292284, 13059.542915997941, 12993.1554448961, 13039.674008149801, 13125.606231813037, 13140.60578182656, 13147.4083666235, 626.4768917953514, 766.8236305649676, 781.5154604145423, 792.9762107136767, 794.4240425691386, 791.584418180457, 791.6912404162381, 794.761571528542, 794.9006374203225, 795.2564352330589, 813.7314686153585, 814.6008455856647, 814.6089876859111, 815.2703330519182, 815.4169768615438, 639.8880195965711, 790.9881351779728, 806.0126345227109, 814.5194335342118, 816.9183081691842, 594.3224723814855, 594.3699678340972, 594.5243804956061, 594.5897330841706, 594.8066878264582, 13146.4084116215, 13186.340682965909, 13188.0, 13192.0, 13211.735765284737, 11554.248973816675, 11846.644600661994, 12141.93929030358, 12402.25586464815, 12555.309457979807, 11378.886211137866, 11384.0, 11556.191066625339, 11873.287602743776, 11988.880111198863, 4147.170565886805, 4148.743999441121, 4171.582841715835, 4323.178596066738, 4357.041450880801, 56116.71941640266, 57062.0, 57214.7139264301, 57287.71356143193, 57631.71184144094, 9406.294527910433, 9463.195628371666, 9531.285153613506, 9611.327207095435, 9776.21790256792, 17409.0, 17466.388676396266, 17495.125243737763, 17495.562610934827, 17496.387626433014, 6488.253850807123, 6548.377904099103, 6594.406503414716, 6648.202215734046, 6725.192976842713, 3517.771344862576, 3537.663921927413, 3543.75193736436, 3616.6021737608844, 3621.420572708354, 2547.0, 2634.394089359458, 2635.3543381871564, 3058.571799948009, 3183.1882869868036, 412.69767333535066, 538.8437353167616, 546.8304825504107, 555.5028249716481, 566.7761234312424, 428.52433798483656, 457.50589363487353, 481.95896862776937, 489.2172523961704, 556.3518500946352, 7622.466427350143, 7792.337651299589, 7829.804254893673, 7964.641591128413, 8075.838483230303, 451.27795527156945, 458.7981288233167, 494.7921872813427, 515.9011305918369, 521.0412840373731, 3551.5027896094566, 3798.848046078126, 3822.961770382316, 3869.090763670535, 3894.6884249259992, 53478.7326063375, 53542.732286338316, 53574.196387054224, 53589.0, 83675.16324836796, 48518.0, 71267.0, 77081.2291877074, 77855.0, 82866.58566707128, 70252.29747702662, 70730.64634676794, 71517.6424117876, 74000.62999684968, 74184.62907685534, 7214.819629509095, 7327.596982166032, 7350.889736654061, 7398.519096258726, 7409.740659076906, 43027.0, 43339.349909750745, 44328.0, 44525.777371112934, 45353.54646453625, 54219.186712198556, 54355.45644543504, 55662.44337556572, 60739.0, 62142.68928655328, 8910.509921954355, 8959.283257339528, 9005.729828105168, 9228.261739060994, 9357.625694972125, 10053.798924021625, 10090.2432317575, 10134.087932086148, 10168.389896606228, 10233.795324093328, 8266.45224765373, 10373.948130259301, 11081.889181108085, 11120.777584448104, 11206.943965280447, 10781.245312828027, 11000.449977501254, 11073.335599864035, 11545.826812597987, 11569.363684997406, 10490.580376784843, 10512.684619461428, 10914.72713182145, 10941.12471002302, 11024.118070554176, 9099.454032758056, 9288.58201380953, 9477.668281610111, 9511.476868772284, 9627.9037209627, 9455.219197322558, 9569.521523923915, 9621.56702948355, 9637.951810240904, 9833.459159745997], "value": 6176.844609383646, "unit": "score"}], "name": "dromaeo_css", "value": 6284.859835595128, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 114.0, 113.0, 116.0, 113.0, 112.0, 114.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 139.0, 132.0, 188.0, 129.0, 133.0, 155.0, 132.0, 206.0, 130.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 164.0, 162.0, 161.0, 164.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 112.0, 76.0, 77.0, 75.0, 74.0, 98.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 120.0, 87.0, 93.0, 86.0, 119.0, 85.0, 87.0, 132.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 84.0, 85.0, 85.0, 85.0, 122.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 132.0, 143.0, 129.0, 145.0, 141.0, 132.0, 137.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 172.0, 171.0, 169.0, 174.0, 170.0, 169.0, 174.0, 167.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 70.0, 71.0, 71.0, 65.0, 68.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1557.1999999999998, "alertThreshold": 2.0}]} 17:52:45 INFO - Return code: 0 17:52:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:52:45 ERROR - # TBPL SUCCESS # 17:52:45 INFO - Running post-action listener: _resource_record_post_action 17:52:45 INFO - ##### 17:52:45 INFO - ##### Finished run-tests step (success) 17:52:45 INFO - ##### 17:52:45 INFO - Running post-run listener: _resource_record_post_run 17:52:45 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 535937024; Read time: 0; Write time: 556416 17:52:45 INFO - TinderboxPrint: CPU usage
13.1% 17:52:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:52:45 INFO - TinderboxPrint: I/O write bytes / time
535,937,024 / 556,416 17:52:45 INFO - TinderboxPrint: CPU idle
8,326.7 (86.9%) 17:52:45 INFO - TinderboxPrint: CPU user
1,211.9 (12.6%) 17:52:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:52:45 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 243933184; Read time: 0; Write time: 347512 17:52:45 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 292003840; Read time: 0; Write time: 208904 17:52:46 INFO - Running post-run listener: _upload_blobber_files 17:52:46 INFO - Blob upload gear active. 17:52:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:52:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:52:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:50 INFO - (blobuploader) - INFO - Done attempting. 17:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:52 INFO - (blobuploader) - INFO - Done attempting. 17:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:52 INFO - (blobuploader) - INFO - Done attempting. 17:52:52 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:52 INFO - Return code: 0 17:52:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff93bc90c6160e2faa2573006e1893bb0fccd480ff35d680f52f518e085eb357528ba477926394e2d676cf01f2ca7b6cadcfe09ae497ac01d8635ab1efe7937f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c949c2f6c36084f5d038f191427b2db4474b244c5550b272026a41b03ec79eaa3899a56e16e2fb39d587f0244981fbb39de3bc268832906a7ed816e2d6f154a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fb986fd0bf8d247579440f242060868a16c05583b44b220861585498b66a9cc3e4d56fd1edb10c05889fd0009769af4c7dec86d53dae1560d9e23df1d12e659"} 17:52:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:52 INFO - Contents: 17:52:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff93bc90c6160e2faa2573006e1893bb0fccd480ff35d680f52f518e085eb357528ba477926394e2d676cf01f2ca7b6cadcfe09ae497ac01d8635ab1efe7937f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c949c2f6c36084f5d038f191427b2db4474b244c5550b272026a41b03ec79eaa3899a56e16e2fb39d587f0244981fbb39de3bc268832906a7ed816e2d6f154a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fb986fd0bf8d247579440f242060868a16c05583b44b220861585498b66a9cc3e4d56fd1edb10c05889fd0009769af4c7dec86d53dae1560d9e23df1d12e659"} 17:52:52 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:52 INFO - Copying logs to upload dir... 17:52:52 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.800037 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-08 17:52:52.704233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:52:52.707761) ========= 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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff93bc90c6160e2faa2573006e1893bb0fccd480ff35d680f52f518e085eb357528ba477926394e2d676cf01f2ca7b6cadcfe09ae497ac01d8635ab1efe7937f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c949c2f6c36084f5d038f191427b2db4474b244c5550b272026a41b03ec79eaa3899a56e16e2fb39d587f0244981fbb39de3bc268832906a7ed816e2d6f154a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fb986fd0bf8d247579440f242060868a16c05583b44b220861585498b66a9cc3e4d56fd1edb10c05889fd0009769af4c7dec86d53dae1560d9e23df1d12e659"} build_url:https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011530 build_url: 'https://queue.taskcluster.net/v1/task/B-z33A3WRISpdtiQTDIg4A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff93bc90c6160e2faa2573006e1893bb0fccd480ff35d680f52f518e085eb357528ba477926394e2d676cf01f2ca7b6cadcfe09ae497ac01d8635ab1efe7937f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c949c2f6c36084f5d038f191427b2db4474b244c5550b272026a41b03ec79eaa3899a56e16e2fb39d587f0244981fbb39de3bc268832906a7ed816e2d6f154a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fb986fd0bf8d247579440f242060868a16c05583b44b220861585498b66a9cc3e4d56fd1edb10c05889fd0009769af4c7dec86d53dae1560d9e23df1d12e659"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:52:52.733471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:52:52.733807) ========= 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=d2a8c569965ab8367867b893000001a1-1465432324.607204-2003916279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:52:52.818227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:52:52.818570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:52:52.818885) ========= ========= Total master_lag: 0.17 =========