builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1467040225.79 results: success (0) buildid: 20160627053006 builduid: a67037abe1d24321b35362d85663932b revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.788557) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.789032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.789304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.808218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.808486) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:10:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-06-27 08:10:26 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.892457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.892777) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.942091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:25.942431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:10:26,500 truncating revision to first 12 chars 2016-06-27 08:10:26,500 Setting DEBUG logging. 2016-06-27 08:10:26,500 attempt 1/10 2016-06-27 08:10:26,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/507d73e670e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:10:26,811 unpacking tar archive at: fx-team-507d73e670e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:26.583179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:26.583479) ========= script_repo_revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:26.583900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:26.584168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:10:26.593164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-27 08:10:26.593542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:27 INFO - MultiFileLogger online at 20160627 08:10:27 in /builds/slave/test 08:10:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:10:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:27 INFO - {'append_to_log': False, 08:10:27 INFO - 'base_work_dir': '/builds/slave/test', 08:10:27 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:27 INFO - 'branch': 'Fx-Team', 08:10:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:27 INFO - 'config_files': ('talos/linux_config.py',), 08:10:27 INFO - 'default_actions': ('clobber', 08:10:27 INFO - 'read-buildbot-config', 08:10:27 INFO - 'download-and-extract', 08:10:27 INFO - 'populate-webroot', 08:10:27 INFO - 'create-virtualenv', 08:10:27 INFO - 'install', 08:10:27 INFO - 'run-tests'), 08:10:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:27 INFO - 'download_minidump_stackwalk': True, 08:10:27 INFO - 'download_symbols': 'ondemand', 08:10:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:27 INFO - 'installer_path': 'installer.exe', 08:10:27 INFO - 'log_level': 'info', 08:10:27 INFO - 'log_name': 'talos', 08:10:27 INFO - 'log_to_console': True, 08:10:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:27 INFO - 'opt_config_files': (), 08:10:27 INFO - 'pip_index': False, 08:10:27 INFO - 'sps_profile': False, 08:10:27 INFO - 'sps_profile_interval': 0, 08:10:27 INFO - 'suite': 'dromaeojs', 08:10:27 INFO - 'system_bits': '32', 08:10:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:27 INFO - 'title': 'talos-linux64-ix-040', 08:10:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:27 INFO - 'use_talos_json': True, 08:10:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:27 INFO - 'work_dir': 'build'} 08:10:27 INFO - ##### 08:10:27 INFO - ##### Running clobber step. 08:10:27 INFO - ##### 08:10:27 INFO - Running pre-action listener: _resource_record_pre_action 08:10:27 INFO - Running main action method: clobber 08:10:27 INFO - rmtree: /builds/slave/test/build 08:10:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:27 INFO - Running post-action listener: _resource_record_post_action 08:10:27 INFO - ##### 08:10:27 INFO - ##### Finished clobber step (success) 08:10:27 INFO - ##### 08:10:27 INFO - ##### 08:10:27 INFO - ##### Running read-buildbot-config step. 08:10:27 INFO - ##### 08:10:27 INFO - Running pre-action listener: _resource_record_pre_action 08:10:27 INFO - Running main action method: read_buildbot_config 08:10:27 INFO - Using buildbot properties: 08:10:27 INFO - { 08:10:27 INFO - "project": "", 08:10:27 INFO - "product": "firefox", 08:10:27 INFO - "script_repo_revision": "production", 08:10:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:10:27 INFO - "repository": "", 08:10:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:10:27 INFO - "buildid": "20160627053006", 08:10:27 INFO - "pgo_build": "True", 08:10:27 INFO - "basedir": "/builds/slave/test", 08:10:27 INFO - "buildnumber": 217, 08:10:27 INFO - "slavename": "talos-linux64-ix-040", 08:10:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:10:27 INFO - "platform": "ubuntu64_hw", 08:10:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:10:27 INFO - "branch": "fx-team", 08:10:27 INFO - "repo_path": "integration/fx-team", 08:10:27 INFO - "revision": "507d73e670e6b25171aa135d8cf809ff3f3bf8dd", 08:10:27 INFO - "stage_platform": "linux64-pgo", 08:10:27 INFO - "builduid": "a67037abe1d24321b35362d85663932b", 08:10:27 INFO - "slavebuilddir": "test" 08:10:27 INFO - } 08:10:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:10:27 INFO - Running post-action listener: _resource_record_post_action 08:10:27 INFO - ##### 08:10:27 INFO - ##### Finished read-buildbot-config step (success) 08:10:27 INFO - ##### 08:10:27 INFO - ##### 08:10:27 INFO - ##### Running download-and-extract step. 08:10:27 INFO - ##### 08:10:27 INFO - Running pre-action listener: _resource_record_pre_action 08:10:27 INFO - Running main action method: download_and_extract 08:10:27 INFO - mkdir: /builds/slave/test/build/tests 08:10: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')]} 08:10:27 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:31 INFO - Downloaded 1361 bytes. 08:10:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:31 INFO - Using the following test package requirements: 08:10:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:10:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:10:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'jsshell-linux-x86_64.zip'], 08:10:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:10:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:10:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:10:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:10:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:10:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:31 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:33 INFO - Downloaded 24279315 bytes. 08:10:33 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'] 08:10:33 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 08:10:34 INFO - Return code: 0 08:10:34 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 08:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:34 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:36 INFO - Downloaded 24279315 bytes. 08:10:36 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'] 08:10:36 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 08:10:37 INFO - Return code: 0 08:10: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')]} 08:10:38 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:39 INFO - Downloaded 14405240 bytes. 08:10:39 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'] 08:10:39 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 08:10:39 INFO - Return code: 0 08:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:39 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/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 08:10:41 INFO - Downloaded 60190590 bytes. 08:10:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:41 INFO - mkdir: /builds/slave/test/properties 08:10:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:41 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:41 INFO - Contents: 08:10:41 INFO - build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:41 INFO - Running post-action listener: _resource_record_post_action 08:10:41 INFO - Running post-action listener: set_extra_try_arguments 08:10:41 INFO - ##### 08:10:41 INFO - ##### Finished download-and-extract step (success) 08:10:41 INFO - ##### 08:10:41 INFO - ##### 08:10:41 INFO - ##### Running populate-webroot step. 08:10:41 INFO - ##### 08:10:41 INFO - Running pre-action listener: _resource_record_pre_action 08:10:41 INFO - Running main action method: populate_webroot 08:10:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:41 INFO - '--tppagecycles', 08:10:41 INFO - '7'], 08:10:41 INFO - 'tests': ['tsvgm']}}, 08:10:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['damp', 'tps']}, 08:10:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'tests': ['damp', 'tps']}, 08:10:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['dromaeo_dom']}, 08:10:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['basic_compositor_video']}, 08:10:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['a11yr', 08:10:41 INFO - 'ts_paint', 08:10:41 INFO - 'tpaint', 08:10:41 INFO - 'sessionrestore', 08:10:41 INFO - 'sessionrestore_no_auto_restore', 08:10:41 INFO - 'tabpaint']}, 08:10:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['tsvgx', 08:10:41 INFO - 'tsvgr_opacity', 08:10:41 INFO - 'tart', 08:10:41 INFO - 'tscrollx', 08:10:41 INFO - 'cart']}, 08:10:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:41 INFO - 'tsvgr_opacity', 08:10:41 INFO - 'tart', 08:10:41 INFO - 'tscrollx', 08:10:41 INFO - 'cart']}, 08:10:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'talos_options': ['--disable-e10s'], 08:10:41 INFO - 'tests': ['tp5o']}, 08:10:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'tests': ['tp5o']}, 08:10:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'talos_options': ['--disable-e10s', 08:10:41 INFO - '--xperf_path', 08:10:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:41 INFO - 'tests': ['tp5n']}, 08:10:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:41 INFO - 'talos_options': ['--xperf_path', 08:10:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:41 INFO - 'tests': ['tp5n']}}, 08:10:41 INFO - 'talos.zip': {'path': '', 08:10:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:41 INFO - Running post-action listener: _resource_record_post_action 08:10:41 INFO - ##### 08:10:41 INFO - ##### Finished populate-webroot step (success) 08:10:41 INFO - ##### 08:10:41 INFO - ##### 08:10:41 INFO - ##### Running create-virtualenv step. 08:10:41 INFO - ##### 08:10:41 INFO - Running pre-action listener: _resource_record_pre_action 08:10:41 INFO - Running main action method: create_virtualenv 08:10:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:41 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 08:10:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:41 INFO - Using real prefix '/usr' 08:10:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:44 INFO - Installing pip.................done. 08:10:44 INFO - Return code: 0 08:10:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:10:44 INFO - Using env: {'DISPLAY': ':0', 08:10:44 INFO - 'HOME': '/home/cltbld', 08:10:44 INFO - 'LANG': 'en_US.UTF-8', 08:10:44 INFO - 'LANGUAGE': 'en_US:en', 08:10:44 INFO - 'LOGNAME': 'cltbld', 08:10:44 INFO - 'MAIL': '/var/mail/cltbld', 08:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:44 INFO - 'MOZ_NO_REMOTE': '1', 08:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:44 INFO - 'NO_EM_RESTART': '1', 08:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:44 INFO - 'PWD': '/builds/slave/test', 08:10:44 INFO - 'SHELL': '/bin/bash', 08:10:44 INFO - 'SHLVL': '1', 08:10:44 INFO - 'TERM': 'linux', 08:10:44 INFO - 'TMOUT': '86400', 08:10:44 INFO - 'USER': 'cltbld', 08:10:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:44 INFO - '_': '/tools/buildbot/bin/python'} 08:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:44 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 08:10:44 INFO - Cleaning up... 08:10:44 INFO - Return code: 0 08:10:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:10:44 INFO - Using env: {'DISPLAY': ':0', 08:10:44 INFO - 'HOME': '/home/cltbld', 08:10:44 INFO - 'LANG': 'en_US.UTF-8', 08:10:44 INFO - 'LANGUAGE': 'en_US:en', 08:10:44 INFO - 'LOGNAME': 'cltbld', 08:10:44 INFO - 'MAIL': '/var/mail/cltbld', 08:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:44 INFO - 'MOZ_NO_REMOTE': '1', 08:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:44 INFO - 'NO_EM_RESTART': '1', 08:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:44 INFO - 'PWD': '/builds/slave/test', 08:10:44 INFO - 'SHELL': '/bin/bash', 08:10:44 INFO - 'SHLVL': '1', 08:10:44 INFO - 'TERM': 'linux', 08:10:44 INFO - 'TMOUT': '86400', 08:10:44 INFO - 'USER': 'cltbld', 08:10:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:44 INFO - '_': '/tools/buildbot/bin/python'} 08:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:44 INFO - Downloading/unpacking psutil>=3.1.1 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:46 INFO - Installing collected packages: psutil 08:10:46 INFO - Running setup.py install for psutil 08:10:46 INFO - building 'psutil._psutil_linux' extension 08:10:46 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 08:10:47 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 08:10:47 INFO - building 'psutil._psutil_posix' extension 08:10:47 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 08:10:47 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 08:10:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:47 INFO - Successfully installed psutil 08:10:47 INFO - Cleaning up... 08:10:47 INFO - Return code: 0 08:10:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:10:47 INFO - Using env: {'DISPLAY': ':0', 08:10:47 INFO - 'HOME': '/home/cltbld', 08:10:47 INFO - 'LANG': 'en_US.UTF-8', 08:10:47 INFO - 'LANGUAGE': 'en_US:en', 08:10:47 INFO - 'LOGNAME': 'cltbld', 08:10:47 INFO - 'MAIL': '/var/mail/cltbld', 08:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:47 INFO - 'MOZ_NO_REMOTE': '1', 08:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:47 INFO - 'NO_EM_RESTART': '1', 08:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:47 INFO - 'PWD': '/builds/slave/test', 08:10:47 INFO - 'SHELL': '/bin/bash', 08:10:47 INFO - 'SHLVL': '1', 08:10:47 INFO - 'TERM': 'linux', 08:10:47 INFO - 'TMOUT': '86400', 08:10:47 INFO - 'USER': 'cltbld', 08:10:47 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:47 INFO - '_': '/tools/buildbot/bin/python'} 08:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:49 INFO - Installing collected packages: mozsystemmonitor 08:10:49 INFO - Running setup.py install for mozsystemmonitor 08:10:49 INFO - Successfully installed mozsystemmonitor 08:10:49 INFO - Cleaning up... 08:10:49 INFO - Return code: 0 08:10:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:49 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')]} 08:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:49 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')]} 08:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:49 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:49 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 08:10:49 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 08:10:49 INFO - Using env: {'DISPLAY': ':0', 08:10:49 INFO - 'HOME': '/home/cltbld', 08:10:49 INFO - 'LANG': 'en_US.UTF-8', 08:10:49 INFO - 'LANGUAGE': 'en_US:en', 08:10:49 INFO - 'LOGNAME': 'cltbld', 08:10:49 INFO - 'MAIL': '/var/mail/cltbld', 08:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:49 INFO - 'MOZ_NO_REMOTE': '1', 08:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:49 INFO - 'NO_EM_RESTART': '1', 08:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:49 INFO - 'PWD': '/builds/slave/test', 08:10:49 INFO - 'SHELL': '/bin/bash', 08:10:49 INFO - 'SHLVL': '1', 08:10:49 INFO - 'TERM': 'linux', 08:10:49 INFO - 'TMOUT': '86400', 08:10:49 INFO - 'USER': 'cltbld', 08:10:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:49 INFO - '_': '/tools/buildbot/bin/python'} 08:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:50 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 08:10:50 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 08:10:50 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 08:10:50 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 08:10:50 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 08:10:50 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 08:10:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:51 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 08:10:51 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 08:10:51 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 08:10:51 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 08:10:51 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 08:10:51 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 08:10:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:52 INFO - warning: no files found matching '*.txt' 08:10:52 INFO - no previously-included directories found matching 'build' 08:10:52 INFO - no previously-included directories found matching 'dist' 08:10:52 INFO - no previously-included directories found matching '.git*' 08:10:52 INFO - Installing collected packages: jsonschema, functools32 08:10:52 INFO - Running setup.py install for functools32 08:10:52 INFO - warning: no files found matching '*.txt' 08:10:52 INFO - no previously-included directories found matching 'build' 08:10:52 INFO - no previously-included directories found matching 'dist' 08:10:52 INFO - no previously-included directories found matching '.git*' 08:10:52 INFO - Successfully installed jsonschema functools32 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10:52 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')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:52 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 08:10:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:54 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 08:10:54 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 08:10:54 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 08:10:54 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 08:10:54 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 08:10:54 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 08:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:55 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 08:10:55 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 08:10:55 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 08:10:55 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 08:10:55 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 08:10:55 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 08:10:55 INFO - Downloading docopt-0.6.1.tar.gz 08:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:55 INFO - Running setup.py install for blobuploader 08:10:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:55 INFO - Running setup.py install for requests 08:10:55 INFO - Running setup.py install for docopt 08:10:55 INFO - Successfully installed blobuploader requests docopt 08:10:55 INFO - Cleaning up... 08:10:55 INFO - Return code: 0 08:10:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:55 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')]} 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:55 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')]} 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:55 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:55 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 08:10:55 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 08:10:55 INFO - Using env: {'DISPLAY': ':0', 08:10:55 INFO - 'HOME': '/home/cltbld', 08:10:55 INFO - 'LANG': 'en_US.UTF-8', 08:10:55 INFO - 'LANGUAGE': 'en_US:en', 08:10:55 INFO - 'LOGNAME': 'cltbld', 08:10:55 INFO - 'MAIL': '/var/mail/cltbld', 08:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:55 INFO - 'MOZ_NO_REMOTE': '1', 08:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:55 INFO - 'NO_EM_RESTART': '1', 08:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:55 INFO - 'PWD': '/builds/slave/test', 08:10:55 INFO - 'SHELL': '/bin/bash', 08:10:55 INFO - 'SHLVL': '1', 08:10:55 INFO - 'TERM': 'linux', 08:10:55 INFO - 'TMOUT': '86400', 08:10:55 INFO - 'USER': 'cltbld', 08:10:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:55 INFO - '_': '/tools/buildbot/bin/python'} 08:10:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:56 INFO - Running setup.py (path:/tmp/pip-55ddVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:56 INFO - Running setup.py (path:/tmp/pip-Giv4zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:56 INFO - Running setup.py (path:/tmp/pip-k2ftTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:56 INFO - Running setup.py (path:/tmp/pip-q88dq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:56 INFO - Running setup.py (path:/tmp/pip-WtNCWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:56 INFO - Running setup.py (path:/tmp/pip-cF2Q2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:56 INFO - Running setup.py (path:/tmp/pip-_aGqfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:56 INFO - Running setup.py (path:/tmp/pip-FlS39n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:56 INFO - Running setup.py (path:/tmp/pip-9u4J6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:56 INFO - Running setup.py (path:/tmp/pip-3qY3a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:56 INFO - Running setup.py (path:/tmp/pip-kzjUjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:56 INFO - Running setup.py (path:/tmp/pip-8IFwt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:57 INFO - Running setup.py (path:/tmp/pip-CQApuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:57 INFO - Running setup.py (path:/tmp/pip-esdZmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:57 INFO - Running setup.py (path:/tmp/pip-mYsAms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:57 INFO - Running setup.py (path:/tmp/pip-u5TrQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:57 INFO - Running setup.py (path:/tmp/pip-BOvcfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:57 INFO - Running setup.py install for manifestparser 08:10:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:57 INFO - Running setup.py install for mozcrash 08:10:57 INFO - Running setup.py install for mozdebug 08:10:57 INFO - Running setup.py install for mozdevice 08:10:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:57 INFO - Running setup.py install for mozfile 08:10:57 INFO - Running setup.py install for mozhttpd 08:10:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:57 INFO - Running setup.py install for mozinfo 08:10:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for mozInstall 08:10:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for mozleak 08:10:58 INFO - Running setup.py install for mozlog 08:10:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for moznetwork 08:10:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for mozprocess 08:10:58 INFO - Running setup.py install for mozprofile 08:10:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for mozrunner 08:10:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:58 INFO - Running setup.py install for mozscreenshot 08:10:58 INFO - Running setup.py install for moztest 08:10:59 INFO - Running setup.py install for mozversion 08:10:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:59 INFO - Cleaning up... 08:10:59 INFO - Return code: 0 08:10:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:59 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:10:59 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 08:10:59 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 08:10:59 INFO - Using env: {'DISPLAY': ':0', 08:10:59 INFO - 'HOME': '/home/cltbld', 08:10:59 INFO - 'LANG': 'en_US.UTF-8', 08:10:59 INFO - 'LANGUAGE': 'en_US:en', 08:10:59 INFO - 'LOGNAME': 'cltbld', 08:10:59 INFO - 'MAIL': '/var/mail/cltbld', 08:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:59 INFO - 'MOZ_NO_REMOTE': '1', 08:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:59 INFO - 'NO_EM_RESTART': '1', 08:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:59 INFO - 'PWD': '/builds/slave/test', 08:10:59 INFO - 'SHELL': '/bin/bash', 08:10:59 INFO - 'SHLVL': '1', 08:10:59 INFO - 'TERM': 'linux', 08:10:59 INFO - 'TMOUT': '86400', 08:10:59 INFO - 'USER': 'cltbld', 08:10:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:59 INFO - '_': '/tools/buildbot/bin/python'} 08:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:59 INFO - Running setup.py (path:/tmp/pip-A_7aMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:59 INFO - Running setup.py (path:/tmp/pip-MAfOTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:59 INFO - Running setup.py (path:/tmp/pip-5n9TAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:59 INFO - Running setup.py (path:/tmp/pip-XSgahh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:59 INFO - Running setup.py (path:/tmp/pip-UYcckf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:59 INFO - Running setup.py (path:/tmp/pip-zBrBQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:59 INFO - Running setup.py (path:/tmp/pip-eYLSB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:59 INFO - Running setup.py (path:/tmp/pip-gNxbbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:59 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)) 08:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:59 INFO - Running setup.py (path:/tmp/pip-IxSD0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:00 INFO - Running setup.py (path:/tmp/pip-bYjmfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:00 INFO - Running setup.py (path:/tmp/pip-QRYC43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:00 INFO - Running setup.py (path:/tmp/pip-wTab4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:00 INFO - Running setup.py (path:/tmp/pip-jA5ZBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:00 INFO - Running setup.py (path:/tmp/pip-tUAddt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:00 INFO - Running setup.py (path:/tmp/pip-ZaAAoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:00 INFO - Running setup.py (path:/tmp/pip-qPr0SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:00 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)) 08:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:00 INFO - Running setup.py (path:/tmp/pip-r_MgE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:00 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)) 08:11:00 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)) 08:11:00 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)) 08:11:00 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)) 08:11:00 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)) 08:11:00 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)) 08:11:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:00 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 08:11:00 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 08:11:00 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 08:11:00 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 08:11:00 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 08:11:00 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 08:11:02 INFO - Downloading blessings-1.6.tar.gz 08:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:02 INFO - Installing collected packages: blessings 08:11:02 INFO - Running setup.py install for blessings 08:11:02 INFO - Successfully installed blessings 08:11:02 INFO - Cleaning up... 08:11:02 INFO - Return code: 0 08:11:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:02 INFO - Reading from file tmpfile_stdout 08:11:03 INFO - Current package versions: 08:11:03 INFO - argparse == 1.2.1 08:11:03 INFO - blessings == 1.6 08:11:03 INFO - blobuploader == 1.2.4 08:11:03 INFO - docopt == 0.6.1 08:11:03 INFO - functools32 == 3.2.3-2 08:11:03 INFO - jsonschema == 2.5.1 08:11:03 INFO - manifestparser == 1.1 08:11:03 INFO - mozInstall == 1.12 08:11:03 INFO - mozcrash == 0.17 08:11:03 INFO - mozdebug == 0.1 08:11:03 INFO - mozdevice == 0.48 08:11:03 INFO - mozfile == 1.2 08:11:03 INFO - mozhttpd == 0.7 08:11:03 INFO - mozinfo == 0.9 08:11:03 INFO - mozleak == 0.1 08:11:03 INFO - mozlog == 3.2 08:11:03 INFO - moznetwork == 0.27 08:11:03 INFO - mozprocess == 0.22 08:11:03 INFO - mozprofile == 0.28 08:11:03 INFO - mozrunner == 6.11 08:11:03 INFO - mozscreenshot == 0.1 08:11:03 INFO - mozsystemmonitor == 0.3 08:11:03 INFO - moztest == 0.7 08:11:03 INFO - mozversion == 1.4 08:11:03 INFO - psutil == 3.1.1 08:11:03 INFO - requests == 1.2.3 08:11:03 INFO - wsgiref == 0.1.2 08:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:03 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')]} 08:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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')]} 08:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:11:03 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 08:11:03 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 08:11:03 INFO - Using env: {'DISPLAY': ':0', 08:11:03 INFO - 'HOME': '/home/cltbld', 08:11:03 INFO - 'LANG': 'en_US.UTF-8', 08:11:03 INFO - 'LANGUAGE': 'en_US:en', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MAIL': '/var/mail/cltbld', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SHLVL': '1', 08:11:03 INFO - 'TERM': 'linux', 08:11:03 INFO - 'TMOUT': '86400', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - '_': '/tools/buildbot/bin/python'} 08:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 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)) 08:11:03 INFO - Cleaning up... 08:11:03 INFO - Return code: 0 08:11:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:03 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')]} 08:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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')]} 08:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:11:03 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 08:11:03 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 08:11:03 INFO - Using env: {'DISPLAY': ':0', 08:11:03 INFO - 'HOME': '/home/cltbld', 08:11:03 INFO - 'LANG': 'en_US.UTF-8', 08:11:03 INFO - 'LANGUAGE': 'en_US:en', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MAIL': '/var/mail/cltbld', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SHLVL': '1', 08:11:03 INFO - 'TERM': 'linux', 08:11:03 INFO - 'TMOUT': '86400', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - '_': '/tools/buildbot/bin/python'} 08:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:03 INFO - Cleaning up... 08:11:03 INFO - Return code: 0 08:11:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:11:03 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')]} 08:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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')]} 08:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:03 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 0x7fd7cf363f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x222e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', '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 08:11:03 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 08:11:03 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 08:11:03 INFO - Using env: {'DISPLAY': ':0', 08:11:03 INFO - 'HOME': '/home/cltbld', 08:11:03 INFO - 'LANG': 'en_US.UTF-8', 08:11:03 INFO - 'LANGUAGE': 'en_US:en', 08:11:03 INFO - 'LOGNAME': 'cltbld', 08:11:03 INFO - 'MAIL': '/var/mail/cltbld', 08:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:03 INFO - 'MOZ_NO_REMOTE': '1', 08:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:03 INFO - 'NO_EM_RESTART': '1', 08:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:03 INFO - 'PWD': '/builds/slave/test', 08:11:03 INFO - 'SHELL': '/bin/bash', 08:11:03 INFO - 'SHLVL': '1', 08:11:03 INFO - 'TERM': 'linux', 08:11:03 INFO - 'TMOUT': '86400', 08:11:03 INFO - 'USER': 'cltbld', 08:11:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:03 INFO - '_': '/tools/buildbot/bin/python'} 08:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:03 INFO - Downloading/unpacking flake8 08:11:03 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 08:11:03 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 08:11:03 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 08:11:03 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 08:11:03 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 08:11:03 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 08:11:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:11:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:11:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:05 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 08:11:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:06 INFO - no previously-included directories found matching 'docs/_build' 08:11:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:11:06 INFO - Running setup.py install for pep8 08:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:11:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:11:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:11:06 INFO - no previously-included directories found matching 'docs/_build' 08:11:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:11:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:11:06 INFO - Cleaning up... 08:11:06 INFO - Return code: 0 08:11:06 INFO - Running post-action listener: _resource_record_post_action 08:11:06 INFO - Running post-action listener: _start_resource_monitoring 08:11:06 INFO - Starting resource monitoring. 08:11:06 INFO - ##### 08:11:06 INFO - ##### Finished create-virtualenv step (success) 08:11:06 INFO - ##### 08:11:06 INFO - ##### 08:11:06 INFO - ##### Running install step. 08:11:06 INFO - ##### 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: install 08:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:06 INFO - Reading from file tmpfile_stdout 08:11:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:06 INFO - Reading from file tmpfile_stdout 08:11:06 INFO - Output received: 08:11:06 INFO - Usage: mozinstall [options] installer 08:11:06 INFO - Options: 08:11:06 INFO - -h, --help show this help message and exit 08:11:06 INFO - -d DEST, --destination=DEST 08:11:06 INFO - Directory to install application into. [default: 08:11:06 INFO - "/builds/slave/test"] 08:11:06 INFO - --app=APP Application being installed. [default: firefox] 08:11:06 INFO - mkdir: /builds/slave/test/build/application 08:11:06 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'] 08:11:06 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 08:11:24 INFO - Reading from file tmpfile_stdout 08:11:24 INFO - Output received: 08:11:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:24 INFO - Running post-action listener: _resource_record_post_action 08:11:24 INFO - ##### 08:11:24 INFO - ##### Finished install step (success) 08:11:24 INFO - ##### 08:11:24 INFO - ##### 08:11:24 INFO - ##### Running run-tests step. 08:11:24 INFO - ##### 08:11:24 INFO - Running pre-action listener: _resource_record_pre_action 08:11:24 INFO - Running main action method: run_tests 08:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:24 INFO - Python 2.7.3 08:11:24 INFO - Return code: 0 08:11:24 INFO - grabbing minidump binary from tooltool 08:11:24 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')]} 08:11:24 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 0x22bd6f0>, '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 0x22be5f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22beaa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:24 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 08:11:24 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 08:11:24 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 08:11:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:24 INFO - Return code: 0 08:11:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:11:25 INFO - Return code: 0 08:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 08:11:25 INFO - Using env: {'DISPLAY': ':0', 08:11:25 INFO - 'HOME': '/home/cltbld', 08:11:25 INFO - 'LANG': 'en_US.UTF-8', 08:11:25 INFO - 'LANGUAGE': 'en_US:en', 08:11:25 INFO - 'LOGNAME': 'cltbld', 08:11:25 INFO - 'MAIL': '/var/mail/cltbld', 08:11:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:25 INFO - 'MOZ_NO_REMOTE': '1', 08:11:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:25 INFO - 'NO_EM_RESTART': '1', 08:11:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:25 INFO - 'PWD': '/builds/slave/test', 08:11:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:25 INFO - 'SHELL': '/bin/bash', 08:11:25 INFO - 'SHLVL': '1', 08:11:25 INFO - 'TERM': 'linux', 08:11:25 INFO - 'TMOUT': '86400', 08:11:25 INFO - 'USER': 'cltbld', 08:11:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091', 08:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:25 INFO - '_': '/tools/buildbot/bin/python'} 08:11:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 08:11:25 INFO - mozversion application_buildid: 20160627053006 08:11:25 INFO - mozversion application_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:11:25 INFO - mozversion application_display_name: Nightly 08:11:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:25 INFO - mozversion application_name: Firefox 08:11:25 INFO - mozversion application_remotingname: firefox 08:11:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:25 INFO - mozversion application_vendor: Mozilla 08:11:25 INFO - mozversion application_version: 50.0a1 08:11:25 INFO - mozversion platform_buildid: 20160627053006 08:11:25 INFO - mozversion platform_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:11:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:25 INFO - mozversion platform_version: 50.0a1 08:11:25 INFO - using testdate: 1467040285 08:11:25 INFO - actual date: 1467040285 08:11:25 INFO - starting webserver on 'localhost:48348' 08:11:25 INFO - SUITE-START | Running 2 tests 08:11:25 INFO - TEST-START | dromaeo_css 08:11:25 INFO - operating with platform_type : linux_ 08:11:25 INFO - Initialising browser for dromaeo_css test... 08:11:25 INFO - TEST-INFO | started process 27991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrc0xS/profile http://localhost:48348/getInfo.html) 08:11:29 INFO - PROCESS | 27991 | __metrics Screen width/height:1600/1200 08:11:29 INFO - PROCESS | 27991 | colorDepth:24 08:11:29 INFO - PROCESS | 27991 | Browser inner width/height: 1024/697 08:11:29 INFO - PROCESS | 27991 | __metrics 08:11:30 INFO - PROCESS | 27991 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:31 INFO - TEST-INFO | 27991: exit 0 08:11:31 INFO - Browser initialized. 08:11:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:31 INFO - TEST-INFO | started process 28071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmrc0xS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:43 INFO - PROCESS | 28071 | RSS: Main: 173809664 08:11:43 INFO - PROCESS | 28071 | 08:12:34 INFO - PROCESS | 28071 | 1467040354462 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] 08:14:43 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48348/tests/dromaeo/cssquery-ext.html) 08:14:44 INFO - PROCESS | 28071 | RSS: Main: 264732672 08:14:44 INFO - PROCESS | 28071 | 08:17:46 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-ext.html (next: http://localhost:48348/tests/dromaeo/cssquery-jquery.html) 08:17:47 INFO - PROCESS | 28071 | RSS: Main: 264646656 08:17:47 INFO - PROCESS | 28071 | 08:20:49 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48348/tests/dromaeo/cssquery-mootools.html) 08:20:50 INFO - PROCESS | 28071 | RSS: Main: 263016448 08:20:50 INFO - PROCESS | 28071 | 08:23:52 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48348/tests/dromaeo/cssquery-prototype.html) 08:23:52 INFO - PROCESS | 28071 | RSS: Main: 258322432 08:23:52 INFO - PROCESS | 28071 | 08:26:55 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48348/tests/dromaeo/cssquery-yui.html) 08:26:55 INFO - PROCESS | 28071 | RSS: Main: 224985088 08:26:55 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-yui.html (next: http://localhost:48348/tests/dromaeo/cssquery-dojo.html) 08:29:58 INFO - PROCESS | 28071 | RSS: Main: 298868736 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | __start_tp_report 08:29:58 INFO - PROCESS | 28071 | _x_x_mozilla_page_load 08:29:58 INFO - PROCESS | 28071 | _x_x_mozilla_page_load_details 08:29:58 INFO - PROCESS | 28071 | |i|pagename|runs| 08:29:58 INFO - PROCESS | 28071 | |0;dojo.html;3103.7982531135476;3104.3015321552666;3119.313750974786;3141.1361875484254;3165.699258570435;5170.53465188133;5289.973550132244;5303.787848486061;5378.220158077076;5394.703291318976;5318.202269659553;5351.785928562863;5369.060414427479;5379.731013449332;5381.058314794915;4821.541953514419;4873.878153046185;4895.363602731658;4907.730074845882;5042.621803364744;4919.581835543983;4920.778564964585;5009.524095210949;5035.597152227831;5037.420696619899;4619.861404157864;4667.579917807379;4821.758912054418;4826.734529600871;4908.067467181224;4783.521647835189;4815.301781241736;4816.08494386069;4871.342368780205;4926.310316555685;4847.830325938575;4854.417469903634;4863.416390033219;4865.19724245499;4896.632752543574;5177.042247184283;5287.180487024518;5348.812791552277;5357.276767636358;5399;5778.479936805666;5791.21818554494;5798.768049278024;5818.738156782955;5823.6505809651135;5625;5821.912671309934;5854.326752423483;5859;5873.383294754075;5327.573794096463;5389.407165211824;5397.217403476474;5417.918731219035;5472.5621950243885;5939.198208241918;5963.254593175853;5965.075413310944;5966.164736936832;5967.791127310524;5508.256385387921;5701.116326969326;5717.542596592262;5721.971390143106;5727.455891690282;5671.120976248688;5733.111367738007;5745.368009518949;5786.508146807569;5787.797427090031;5738.626989245686;5777.19119323295;5779.566532510079;5787.276590426197;5787.681677507778;5498.230247765316;5713.914291285634;5783.88432231353;5785.900678871001;5789.797357092481;4408.470983482002;4427.557244275611;4431.689781715313;4465.687401881837;4465.732056076581;3933.4296527004;3944.9605503945168;3956.2878681837547;3973.8807835764974;3979;5239.056969745482;5289.100852855024;5451.04606693827;5458.863528411822;5461.9453805461435;5693.715314234271;5708.286464191976;5729.369769325371;5760.711964401763;5788.739506722208;5396.757145928443;5398.811041613525;5409.350877894678;5413.323334583177;5414.972925135349;4690.202665546865;4798.976005119952;4818.469968303484;4828.203346447867;4857.562819346276;6036.124761909411;6049.576529642883;6050.455459008623;6051;6089.5737298388685;5852.326982397079;5863.120531920246;5867.6772777497645;5875.911861322169;5876.559258055578;5692.6299790513485;5882.205902203319;5942.078977758281;5959.791407300723;6032.819015429544;5657.462541058593;5676.7445464955;5680.204771331934;5685.658860468385;5692.516136128475;5713.8285851424525;5729.054705973635;5765.94234057654;5786.276715410574;5790.044642633919;5437.102878025082;5604.8038318658655;5636.85907852307;5661.773529058792;5710.2291190690385;5664.546836253007;5678.233438485917;5700.629459085146;5710.057840456278;5711.314642242957;5294;5609.635373700697;5617.297837770278;5621.184928185472;5624.409437009219;5528.7235638218735;5548.916766248429;5569.526590239875;5658.434156584309;5663.688497132697;5404.486573775485;5439.564834813126;5446.509814116748;5473.480019398151;5476.3702174250475 08:29:58 INFO - PROCESS | 28071 | |1;ext.html;597.4801922327575;602.4969150759117;606.4451027310012;610.6397225636873;622.8038167977084;31320;34064;34292.82853585735;43018.569814301845;44222.7788861056;45225.54774452255;45729.7713511432;45739.77130114353;45839.31241031387;46069.30896036562;8891.199792018733;9019.54902254888;9035.457872527637;9039.457632542035;9045.140711632384;8881.73354799357;8961.641534338618;8995.595198216064;8996.100389961017;8997.640094396216;8990.68532601359;8993;9022.323325750562;9033.23217526511;9041.09589041094;8989.190972812445;9030.819383612357;9040.321975851837;9045.095490450967;9045.547722613908;8886.377953543255;8909.55452227386;8909.688160914402;8925.776855578597;8975.192232699088;42850.571494284966;43188.784056079516;43255.56744432578;43321.35017974733;43420.565794341965;3729.4778730977687;3777.0557360659836;3812.1041555234497;3924.3132451820816;4140.627343539096;33152.17119572006;33431.33137337264;33581.832090839634;34004.48993265103;34140.14649633754;4192.287311157111;4195.349720793282;4208.516020657602;4265.125649241929;4267.8079486423185;363991;365744.1712791446;365897;366401;366574;57992.420075798706;58003.12995305074;58118.70940645354;58161.709191453774;58172.12741808876;54701.45298546964;59023.40976590265;59400.40599594035;59769.41383517003;60378.09432858511;17300.394486192923;17409.912950435166;17438.215280312164;17459;17486;13632;13768.036237463482;13786.931065344608;13787.931060344834;13795.10331828428;14702.191379474018;15750.448734294245;16093;16111.194440277939;16256.187190640421;5843.152742852262;5903.203067585907;5927.8221653350465;5989;6013.7895173669585;949.8005418861978;998.1615443027891;1026.97432564185;1067.754416484213;1123.5393488669606;32415.892966957545;32839.671603284136;32914.3417131656;32986;33260.334793304;1125.8480105185695;1136.7158210447387;1151.988480115205;1175.3946717440524;1211.158245019703;16938.915305423394;17220.569485762957;17340.393086241922;17455.912720436572;17488.825111748974;567823;571087.5782484327;573701;573849;574075;56297.43702562922;57361.13958290629;57582;57612.711936440886;57615.83112928745;1230.1696354960545;1322.490841026212;1341.7316536692701;1371.5268232459784;1387.3756809435795;32795.508067378534;34109;34396.31207375888;34518.48222276718;34711.631724240644;49673;50250.74874625603;50355.49644503508;50372.748136259084;50428;414237;416921;417743.5805135521;418161;418413;36151.09622259464;40948;41174.79412603038;42093.57906420896;44461;48639;48894;48959;49441;49711.75144124256;40451.8939526248;41454.1709165821;41616.583834162484;41654.95862603459;41852.581474184866;39939.60060399475;40500.59499404968;41405.79297103495;41606.79196603998;41828.58171418247;41232.58767412287;41325.38011929884;42087.579124208365;42403.1519369617;42565.787171063945;34453.48319775155;36467.817660911525;36691.26617467689;36965.815170923976;37231;28141.437171256868;28627.570586440805;28667;28861.422771544872;28904.421911562073 08:29:58 INFO - PROCESS | 28071 | |2;jquery.html;393.602461513871;400.40739705236234;406.14101176012736;409.6824960655492;412.5997782151312;13063.869361306408;18246;19316.51708707283;20073;20110.89944550277;14536.781948270758;17553.912230438862;18796.248150074014;19205.807941920575;19937.202511899544;5609.607327487088;5826.650400975955;5842.6786526741225;5854.297484301868;5855.23881895353;5778.855528611776;5802.796902108427;5833.620814647034;5843.2695913010875;5851.180834683148;4162.687798415116;6068.120122582223;6366;6378.138951241569;6496.155499785022;6178.289496707846;6437.388448097447;6439.678016099177;6464.062710906939;6467.579607325509;5690.48785609293;5706.28671416073;5711.8000869969765;5720.570957178186;5727.083666613322;22599.548009039892;23687.289381318587;24197.63703544448;24270.757292427203;24303.392415189584;2464.8767561622026;2505.3360859372283;2673.919782406531;2967.55486676998;3043.9086827395213;14251.78622320666;14267.215303158322;14709.779353309708;14913.925430372887;15251.23743812816;1963.322653684491;2001.1795163982697;2031.3398145602591;2045.417056139008;2094.4345026842666;79767.60116199382;81353.59323203405;82314.17685823125;82352.58823705903;83796.58101709452;10349.534270957825;10574;10836.241463097665;10971.177161712903;11070.944645276722;14960.775588366183;15040.247987600576;15059.548213553611;15132.394704211709;15171.848281517043;8055.63749631268;8089.433739638286;8124.106348301682;8166.754997350089;8259.091499935003;7826.726064587712;8021.598920053974;8080.515169089756;8102.594870256464;8259.42184047123;5902.557308201902;6222.595531290452;6271.122042913996;6568.638724870082;6789.388954993976;1824.7470169546903;1927.7108433735052;1941.805819418047;1954.6774782160785;1985.662437385648;930.4649826349876;993.3543196921914;998.031909048222;1046.0951277145214;1116.213069785799;19708.802911970983;20250.392488225378;20343;20573.04556067171;20715.689264661043;994.1599348550463;1019.4596863662271;1027.7379268286688;1027.9229057820694;1038.6676263595577;10304.742381440525;11686.941565292289;11737.471813768401;11743.236689615147;11753.236039657395;494396;510359;512568.43715781183;519587;526074;78488;80519.19480805116;81191.5940420294;81353.18646813456;82353.17646823575;1004.1815920025156;1037.8131936251548;1062.1396668698378;1067.4502631144967;1075.188232884183;18155.36456224026;18171.273149073888;18256.543586410447;18330.17514211837;18471.261149554404;42036.15927681368;42132.368014479194;42430;43047.35428968631;43189.352159718255;57040.71479642575;58814.41185588089;59862;60217.69891150516;61060.69469652801;8227.71203007892;8630.007549131678;8697.782555436164;8953.087965654271;8973.865392018994;9821.459819709984;13722;14312.499062532761;14391.856081439051;14411.85588144147;12088.395580220778;12113.878861211628;12397.75204495923;12475.438605262967;12796.360181990676;12070.939645301718;12086.576969806014;12107.334096624418;12206.450709718261;12514.311712855517;12528.060395470195;12568.622941311774;12611.747765044463;12712.555060573206;12812.231266124063;8548.358873084419;8739.257163141205;8806;9038.367314287936;9237.12247336502;11676.70808229801;11952.282863028246;11973.401329933642;12113.81829272544;12127 08:29:58 INFO - PROCESS | 28071 | |3;mootools.html;1281.2248589603284;1310.2727985967788;1413.123863204813;1441.7909403136546;1682.806477255116;8305.83388332233;8734.606942687578;8737.388382813198;8964.193222609963;9000.189982901538;8762.561871906411;8892;8905.287576993842;8941.15059069389;8942.86585701215;1946.8637195396327;2016.2136766661015;2023.959520809583;2275.260540324393;2310.2260742651233;2277.943051423719;2363.89362478688;2364.562555927159;2375.7743014413604;2378.4767351182713;2251.6735073414425;2275.977240227601;2279.6694479300572;2296.0241897193628;2297.3911913342977;1957.7454930858896;2164.9242276520245;2281.3726225288015;2282.851614645051;2288.0275882749847;2191.901364438604;2221.389117992565;2223.7331520217676;2225.121077174507;2227.6992605998144;8946.910530894738;8951;8982.640694372218;8989.730308090768;9001.279897608176;5114.130597798383;5254.737263136866;5257.395399529065;5259.658122222043;5262.368515778093;3149.291409432882;3272.7709060365783;3297.241634424096;3333.9498058111617;3388.2376465295356;1095.2257343104143;1099.7745462180235;1105.2594761509808;1110.566878917223;1121.8373335866254;12698.619041428772;12709.618711438672;12718.682032949158;12728.1726687765;12728.490860365575;4543.522930092358;4544.113897789899;4646.4191976003;4660.254359302563;4662.6269898408045;10714.946425267824;10725.78548429027;10726.088282496075;10737.033666969854;10743.78512429747;5293.338332708411;5298.231756395301;5298.602604804578;5307.4692530746615;5308.46915308466;4115.382692596135;4692.7653617319;4824.179889418807;4876.829310974099;4947.777350019258;4017.1764788218347;4042.514898212233;4088.1823635273063;4141.544430112685;4175.06061136248;1212.9454174562165;1242.3974372429363;1244.2161438293997;1244.7821631214683;1282.6280378690076;822.6873787960536;826.8304997475503;913.6528119314618;928.5821380378857;956.2015716876347;5740.68426236561;5812.38969908162;5880.382559831156;5942.554308426886;5989.1914591529585;977.8266080703185;983.5573991703762;1008.7189269627679;1012.64051261801;1014.1278500489573;3926.6662333701383;4065.735727177724;4073.7759423232005;4083.7549747015273;4137.793110344471;10952.178586606036;11142.331460112257;11218.607348742918;11345.829812552818;11395.202335836411;10893.237473376947;11076.390798505998;11128.554857805759;11199.888001120047;11205.04757095656;8370.539620320818;8485.915140848636;8485.95757021211;8506.234438900528;8520.786980325418;5689.54483641316;5918.822435326947;5923.644581325134;5960.523158147251;5972.134040564007;10128.442935638315;10336.759588849387;10360.274780765274;10370.27408081427;10496.05535501778;10470.790584188426;10476.440386776616;10557.788844223227;10600.0989915858;10750.623728169476;6999.685014174476;7419.591922444318;7654.425918056057;7664.31021208094;7786.182450842806;8961.596728147379;9007.324450666358;9039.548022598712;9046.321525885453;9055.094490550891;7897.605119743875;8048.678052877819;8105.473144245605;8146.429749917449;8240.876386854083;7658.081030276402;7846.450748447553;7886.802829929297;7918.089419716806;8055.3152981994845;7365.705371785069;7395.408367330493;7396.889046664412;7490.475666703279;7505.211952744883;5158.09733296679;5232.869178270422;5238.580913526985;5249.2126181073145;5292.920606190987;4810.39870016248;4870;4877.365942427462;5003.374578177728;5101.9489805101475 08:29:58 INFO - PROCESS | 28071 | |4;prototype.html;294.64495283183766;300.10269294808523;304.9939001219975;308.1495073596872;308.7098127759907;5077.492250774921;5123.53979115952;5164.638475306725;5210.010098081367;5221.190715439104;5148.8929880075775;5188.792448302072;5200.817971371002;5214.165733482643;5226.686398816074;4016.4778578784717;4022.235775202702;4022.3162062449305;4046.3525835866267;4055.1889622075705;3812.1613245086037;3862.1310205203886;4016.15660711251;4027.2750904837117;4032.1129351542613;4011.438398624195;4042;4057.4928133983253;4059.1678705865374;4064.796760161995;4020.4170395292663;4033.9193216135805;4035.515738111416;4041.2725709372303;4070.903484705379;3509.5963964144194;3571.5892672342493;3580.606133325332;3593.1915319053264;3593.5508061492314;5072.213806859942;5076.517730815566;5085.211792172219;5093.414257360414;5110.386753589593;4543.750093744843;4631.1895418301665;4637.420322459692;4639.304104384336;4654.162250794856;5230.581553475751;5443.2107344435235;5444.292242008513;5450.75679970421;5465.152901300305;3879.7478163919536;3899.3566061599804;3909.0618251619408;3913.5499417566775;3942.6792024671768;5656.208130861683;5683.204351390808;5693;5711.657300561979;5714.914276285859;4038.8788336349958;4045.6358927696647;4049.7165198436414;4052.2908491013955;4071.4096456014304;3909.863154789569;4011.438398624195;4020.8391664333685;4023.3562629979065;4028.8992775180855;4566.3150527420485;4598.149342371672;4611.492735799059;4620.168369693488;4629.560191781776;5367.731613419313;5388.164834450667;5495.230667706524;5502.449755024546;5547.585365731713;1274.898008159345;1304.1132030219542;1381.599336192513;1386.8766299297602;1387.9167249965035;880.7093659092484;889.9110088991049;890.7218141966299;899.8965119011398;922.3036607361399;4647.651426143053;4667.883302917454;4686.320483529869;4689.60138388234;4691.780137164294;4889.193283108319;4955.231939049453;4965.553100220997;4971.141593583631;5005.874853128628;4613.261878099555;4621.815127394933;4665.5567721066445;4711.552402521755;4722.244440889442;2749.6150538924567;2981.1652737233608;2990.5065664165168;3008.669046404894;3013.3426615361464;5802.912956305659;5821.962313190349;5863.299643103453;5895.757333466576;5908.291005079418;5521.475459831309;5645.943540564624;5667.801626943037;5793.798356624456;5808.680522571299;5766.279215098113;5787.565932554991;5801.042827933344;5807.157962095473;5835.679037652885;5618.831435056954;5657.830265092054;5658.688772117573;5663.830085097454;5669.299210236995;5305.204219367126;5587.6088673794075;5602.691851948182;5608.523275521463;5641.545927521542;5829.417058294306;5849.94150058494;5867.9413205869105;5868.3251426086545;5906.26171728534;3863.5704789228166;3878.9268697732527;3915.9021024474614;3924.843006279717;3946.8223929923797;5617.859553511032;5622.746976385991;5636.661800291996;5655.2648155741135;5657.660540367591;5483.506484416422;5508.421615730291;5525.364583072998;5595.832125036255;5596.377050655265;5301.8144364948585;5523.28197334344;5528.530074943675;5580.358258800127;5612.354579223442;5413.106837371947;5414.485623865727;5423.806762512241;5452.372977107683;5501.779928802803;5582.27430434041;5609.513478928169;5615.7192140392;5621.578381621313;5634.492895639412;5188.533032027136;5445.50990410865;5452.509274165344;5467.152591348347;5469.644473109235 08:29:58 INFO - PROCESS | 28071 | |5;yui.html;752.4995877741302;768.0246087468918;769.460779427888;797.3700776386655;828.1801016993177;13939.233342166177;14677.266136693162;14685.265736713149;14694;14702.63243418915;12613.810792838114;13603.319834008309;13695.520656777015;13713;13725.107867988574;670.1054092786112;785.5993443343893;786.7521730654854;800.5556915911667;807.9757607271791;797.5493845977004;801.3829351399419;802.1016461563057;802.1096582793095;802.3019972623825;847.2374862623626;848.4951453884929;854.2311919272643;854.8717692346166;854.8760429737684;699.3810477727197;810.6473683947472;827.1067247372823;828.0022572799762;849.6558893648051;606.1120458528234;606.648144076439;607.1105829959087;607.1894021481328;608.528390497368;13149;13183.604491865259;13196.604101876863;13203.471861125543;13206.603801885958;13079.542216022488;13236.669083272898;13302.068855180141;13479.123856949267;13650.180989140585;12897.226166430044;12998.155119917175;13046.804297935538;13258.403371848193;13401.128926619836;4601.7699115044115;4634.060293467318;4703.247480403119;4712.764361781898;4736.218523943545;72236.63881680611;72277;74427;75253;76330.61834690846;11197.832032519518;11329.263597866113;11360.943195283971;11408.272671406381;11544.538218471334;19660.21359145618;20380.490487737927;20408.591828163353;20413.285535006202;20420.795792042187;8599.699010534601;8675.869861952076;8757.255633271116;8776.254018408506;8885.866711999326;4798.5441383068555;4847.660663753503;4869.537393947569;4993.2010878260035;5079.6952182869145;3044.74119699828;3150.5431712402033;3181.3955348483714;3181.4750566156786;3186.4105140549073;561.7809054468761;574.6178791103869;586.8268860686107;593.1666009256915;628.7579281976381;681.4922882452605;682.8361193313569;730.7844185965153;749.3742724824723;789.1753117991713;9445.622175113056;9638.518074096268;9782.364146330608;9899.703008909744;10018.3488073275;633.7908490198223;702.1468915267974;717.4117223876475;721.9025431566671;738.3908275672592;4448;4664.346991421204;4667.8366257181515;4785.569298763058;4822.7829747661435;81001.59499202466;127176;127453;127606;129762.35118824345;106311.93688063175;106422;106797;108666;108710.45644771725;93854.53072734593;96701.5164924185;97425;97473.5126324378;101254;8921.598528066383;8956.238719708897;8987;8989.101089890959;9026.368154229142;56253.71873140608;56406.43593564012;57691;57763;57851.1322330157;77380.6130969364;79785;82835.5858220705;83455.582722086;85741;12132.696682583006;12139.393030348623;12227.388630568257;12377.938110309751;12538.435770390537;14073.648158796112;14472.855271447152;14657.853421465648;15087.4719384821;15571.922140389226;12708.87291127077;12786.936065319614;12870.678233043875;12877.678058048623;13413.66465838362;12995.155314904501;13416.32918354098;13774.332643752328;14138.929305353407;14766.926165369105;12419.503219871465;12428.316442595382;12608.49566017349;12651.746965060463;12744.553940612033;11290.209685322277;11449.828252576384;11457;11461.885381146081;11499.425028748696;10735.838962415413;10744.51649675782;11049.28179668319;11069.280496767684;11099.94450027777 08:29:58 INFO - PROCESS | 28071 | __end_tp_report 08:29:58 INFO - PROCESS | 28071 | __start_cc_report 08:29:58 INFO - PROCESS | 28071 | _x_x_mozilla_cycle_collect,879 08:29:58 INFO - PROCESS | 28071 | __end_cc_report 08:29:58 INFO - PROCESS | 28071 | __startTimestamp1467041398772__endTimestamp 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | ------- Summary: start ------- 08:29:58 INFO - PROCESS | 28071 | Number of tests: 6 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#0] dojo.html Cycles:165 Average:5340.41 Median:5498.23 stddev:616.22 (11.2%) stddev-sans-first:592.61 08:29:58 INFO - PROCESS | 28071 | Values: 3103.8 3104.3 3119.3 3141.1 3165.7 5170.5 5290.0 5303.8 5378.2 5394.7 5318.2 5351.8 5369.1 5379.7 5381.1 4821.5 4873.9 4895.4 4907.7 5042.6 4919.6 4920.8 5009.5 5035.6 5037.4 4619.9 4667.6 4821.8 4826.7 4908.1 4783.5 4815.3 4816.1 4871.3 4926.3 4847.8 4854.4 4863.4 4865.2 4896.6 5177.0 5287.2 5348.8 5357.3 5399.0 5778.5 5791.2 5798.8 5818.7 5823.7 5625.0 5821.9 5854.3 5859.0 5873.4 5327.6 5389.4 5397.2 5417.9 5472.6 5939.2 5963.3 5965.1 5966.2 5967.8 5508.3 5701.1 5717.5 5722.0 5727.5 5671.1 5733.1 5745.4 5786.5 5787.8 5738.6 5777.2 5779.6 5787.3 5787.7 5498.2 5713.9 5783.9 5785.9 5789.8 4408.5 4427.6 4431.7 4465.7 4465.7 3933.4 3945.0 3956.3 3973.9 3979.0 5239.1 5289.1 5451.0 5458.9 5461.9 5693.7 5708.3 5729.4 5760.7 5788.7 5396.8 5398.8 5409.4 5413.3 5415.0 4690.2 4799.0 4818.5 4828.2 4857.6 6036.1 6049.6 6050.5 6051.0 6089.6 5852.3 5863.1 5867.7 5875.9 5876.6 5692.6 5882.2 5942.1 5959.8 6032.8 5657.5 5676.7 5680.2 5685.7 5692.5 5713.8 5729.1 5765.9 5786.3 5790.0 5437.1 5604.8 5636.9 5661.8 5710.2 5664.5 5678.2 5700.6 5710.1 5711.3 5294.0 5609.6 5617.3 5621.2 5624.4 5528.7 5548.9 5569.5 5658.4 5663.7 5404.5 5439.6 5446.5 5473.5 5476.4 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#1] ext.html Cycles:180 Average:61471.60 Median:23022.43 stddev:122052.25 (530.1%) stddev-sans-first:122309.06 08:29:58 INFO - PROCESS | 28071 | Values: 597.5 602.5 606.4 610.6 622.8 31320.0 34064.0 34292.8 43018.6 44222.8 45225.5 45729.8 45739.8 45839.3 46069.3 8891.2 9019.5 9035.5 9039.5 9045.1 8881.7 8961.6 8995.6 8996.1 8997.6 8990.7 8993.0 9022.3 9033.2 9041.1 8989.2 9030.8 9040.3 9045.1 9045.5 8886.4 8909.6 8909.7 8925.8 8975.2 42850.6 43188.8 43255.6 43321.4 43420.6 3729.5 3777.1 3812.1 3924.3 4140.6 33152.2 33431.3 33581.8 34004.5 34140.1 4192.3 4195.3 4208.5 4265.1 4267.8 363991.0 365744.2 365897.0 366401.0 366574.0 57992.4 58003.1 58118.7 58161.7 58172.1 54701.5 59023.4 59400.4 59769.4 60378.1 17300.4 17409.9 17438.2 17459.0 17486.0 13632.0 13768.0 13786.9 13787.9 13795.1 14702.2 15750.4 16093.0 16111.2 16256.2 5843.2 5903.2 5927.8 5989.0 6013.8 949.8 998.2 1027.0 1067.8 1123.5 32415.9 32839.7 32914.3 32986.0 33260.3 1125.8 1136.7 1152.0 1175.4 1211.2 16938.9 17220.6 17340.4 17455.9 17488.8 567823.0 571087.6 573701.0 573849.0 574075.0 56297.4 57361.1 57582.0 57612.7 57615.8 1230.2 1322.5 1341.7 1371.5 1387.4 32795.5 34109.0 34396.3 34518.5 34711.6 49673.0 50250.7 50355.5 50372.7 50428.0 414237.0 416921.0 417743.6 418161.0 418413.0 36151.1 40948.0 41174.8 42093.6 44461.0 48639.0 48894.0 48959.0 49441.0 49711.8 40451.9 41454.2 41616.6 41655.0 41852.6 39939.6 40500.6 41405.8 41606.8 41828.6 41232.6 41325.4 42087.6 42403.2 42565.8 34453.5 36467.8 36691.3 36965.8 37231.0 28141.4 28627.6 28667.0 28861.4 28904.4 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#2] jquery.html Cycles:180 Average:29728.61 Median:2485.11 stddev:84167.09 (3386.9%) stddev-sans-first:84374.38 08:29:58 INFO - PROCESS | 28071 | Values: 393.6 400.4 406.1 409.7 412.6 13063.9 18246.0 19316.5 20073.0 20110.9 14536.8 17553.9 18796.2 19205.8 19937.2 5609.6 5826.7 5842.7 5854.3 5855.2 5778.9 5802.8 5833.6 5843.3 5851.2 4162.7 6068.1 6366.0 6378.1 6496.2 6178.3 6437.4 6439.7 6464.1 6467.6 5690.5 5706.3 5711.8 5720.6 5727.1 22599.5 23687.3 24197.6 24270.8 24303.4 2464.9 2505.3 2673.9 2967.6 3043.9 14251.8 14267.2 14709.8 14913.9 15251.2 1963.3 2001.2 2031.3 2045.4 2094.4 79767.6 81353.6 82314.2 82352.6 83796.6 10349.5 10574.0 10836.2 10971.2 11070.9 14960.8 15040.2 15059.5 15132.4 15171.8 8055.6 8089.4 8124.1 8166.8 8259.1 7826.7 8021.6 8080.5 8102.6 8259.4 5902.6 6222.6 6271.1 6568.6 6789.4 1824.7 1927.7 1941.8 1954.7 1985.7 930.5 993.4 998.0 1046.1 1116.2 19708.8 20250.4 20343.0 20573.0 20715.7 994.2 1019.5 1027.7 1027.9 1038.7 10304.7 11686.9 11737.5 11743.2 11753.2 494396.0 510359.0 512568.4 519587.0 526074.0 78488.0 80519.2 81191.6 81353.2 82353.2 1004.2 1037.8 1062.1 1067.5 1075.2 18155.4 18171.3 18256.5 18330.2 18471.3 42036.2 42132.4 42430.0 43047.4 43189.4 57040.7 58814.4 59862.0 60217.7 61060.7 8227.7 8630.0 8697.8 8953.1 8973.9 9821.5 13722.0 14312.5 14391.9 14411.9 12088.4 12113.9 12397.8 12475.4 12796.4 12070.9 12086.6 12107.3 12206.5 12514.3 12528.1 12568.6 12611.7 12712.6 12812.2 8548.4 8739.3 8806.0 9038.4 9237.1 11676.7 11952.3 11973.4 12113.8 12127.0 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#3] mootools.html Cycles:180 Average:5880.63 Median:4595.27 stddev:3438.78 (74.8%) stddev-sans-first:3431.05 08:29:58 INFO - PROCESS | 28071 | Values: 1281.2 1310.3 1413.1 1441.8 1682.8 8305.8 8734.6 8737.4 8964.2 9000.2 8762.6 8892.0 8905.3 8941.2 8942.9 1946.9 2016.2 2024.0 2275.3 2310.2 2277.9 2363.9 2364.6 2375.8 2378.5 2251.7 2276.0 2279.7 2296.0 2297.4 1957.7 2164.9 2281.4 2282.9 2288.0 2191.9 2221.4 2223.7 2225.1 2227.7 8946.9 8951.0 8982.6 8989.7 9001.3 5114.1 5254.7 5257.4 5259.7 5262.4 3149.3 3272.8 3297.2 3333.9 3388.2 1095.2 1099.8 1105.3 1110.6 1121.8 12698.6 12709.6 12718.7 12728.2 12728.5 4543.5 4544.1 4646.4 4660.3 4662.6 10714.9 10725.8 10726.1 10737.0 10743.8 5293.3 5298.2 5298.6 5307.5 5308.5 4115.4 4692.8 4824.2 4876.8 4947.8 4017.2 4042.5 4088.2 4141.5 4175.1 1212.9 1242.4 1244.2 1244.8 1282.6 822.7 826.8 913.7 928.6 956.2 5740.7 5812.4 5880.4 5942.6 5989.2 977.8 983.6 1008.7 1012.6 1014.1 3926.7 4065.7 4073.8 4083.8 4137.8 10952.2 11142.3 11218.6 11345.8 11395.2 10893.2 11076.4 11128.6 11199.9 11205.0 8370.5 8485.9 8486.0 8506.2 8520.8 5689.5 5918.8 5923.6 5960.5 5972.1 10128.4 10336.8 10360.3 10370.3 10496.1 10470.8 10476.4 10557.8 10600.1 10750.6 6999.7 7419.6 7654.4 7664.3 7786.2 8961.6 9007.3 9039.5 9046.3 9055.1 7897.6 8048.7 8105.5 8146.4 8240.9 7658.1 7846.5 7886.8 7918.1 8055.3 7365.7 7395.4 7396.9 7490.5 7505.2 5158.1 5232.9 5238.6 5249.2 5292.9 4810.4 4870.0 4877.4 5003.4 5101.9 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#4] prototype.html Cycles:180 Average:4558.05 Median:5116.96 stddev:1359.71 (26.6%) stddev-sans-first:1325.34 08:29:58 INFO - PROCESS | 28071 | Values: 294.6 300.1 305.0 308.1 308.7 5077.5 5123.5 5164.6 5210.0 5221.2 5148.9 5188.8 5200.8 5214.2 5226.7 4016.5 4022.2 4022.3 4046.4 4055.2 3812.2 3862.1 4016.2 4027.3 4032.1 4011.4 4042.0 4057.5 4059.2 4064.8 4020.4 4033.9 4035.5 4041.3 4070.9 3509.6 3571.6 3580.6 3593.2 3593.6 5072.2 5076.5 5085.2 5093.4 5110.4 4543.8 4631.2 4637.4 4639.3 4654.2 5230.6 5443.2 5444.3 5450.8 5465.2 3879.7 3899.4 3909.1 3913.5 3942.7 5656.2 5683.2 5693.0 5711.7 5714.9 4038.9 4045.6 4049.7 4052.3 4071.4 3909.9 4011.4 4020.8 4023.4 4028.9 4566.3 4598.1 4611.5 4620.2 4629.6 5367.7 5388.2 5495.2 5502.4 5547.6 1274.9 1304.1 1381.6 1386.9 1387.9 880.7 889.9 890.7 899.9 922.3 4647.7 4667.9 4686.3 4689.6 4691.8 4889.2 4955.2 4965.6 4971.1 5005.9 4613.3 4621.8 4665.6 4711.6 4722.2 2749.6 2981.2 2990.5 3008.7 3013.3 5802.9 5822.0 5863.3 5895.8 5908.3 5521.5 5645.9 5667.8 5793.8 5808.7 5766.3 5787.6 5801.0 5807.2 5835.7 5618.8 5657.8 5658.7 5663.8 5669.3 5305.2 5587.6 5602.7 5608.5 5641.5 5829.4 5849.9 5867.9 5868.3 5906.3 3863.6 3878.9 3915.9 3924.8 3946.8 5617.9 5622.7 5636.7 5655.3 5657.7 5483.5 5508.4 5525.4 5595.8 5596.4 5301.8 5523.3 5528.5 5580.4 5612.4 5413.1 5414.5 5423.8 5452.4 5501.8 5582.3 5609.5 5615.7 5621.6 5634.5 5188.5 5445.5 5452.5 5467.2 5469.6 08:29:58 INFO - PROCESS | 28071 | 08:29:58 INFO - PROCESS | 28071 | [#5] yui.html Cycles:180 Average:21556.37 Median:4685.54 stddev:32194.14 (687.1%) stddev-sans-first:32246.55 08:29:58 INFO - PROCESS | 28071 | Values: 752.5 768.0 769.5 797.4 828.2 13939.2 14677.3 14685.3 14694.0 14702.6 12613.8 13603.3 13695.5 13713.0 13725.1 670.1 785.6 786.8 800.6 808.0 797.5 801.4 802.1 802.1 802.3 847.2 848.5 854.2 854.9 854.9 699.4 810.6 827.1 828.0 849.7 606.1 606.6 607.1 607.2 608.5 13149.0 13183.6 13196.6 13203.5 13206.6 13079.5 13236.7 13302.1 13479.1 13650.2 12897.2 12998.2 13046.8 13258.4 13401.1 4601.8 4634.1 4703.2 4712.8 4736.2 72236.6 72277.0 74427.0 75253.0 76330.6 11197.8 11329.3 11360.9 11408.3 11544.5 19660.2 20380.5 20408.6 20413.3 20420.8 8599.7 8675.9 8757.3 8776.3 8885.9 4798.5 4847.7 4869.5 4993.2 5079.7 3044.7 3150.5 3181.4 3181.5 3186.4 561.8 574.6 586.8 593.2 628.8 681.5 682.8 730.8 749.4 789.2 9445.6 9638.5 9782.4 9899.7 10018.3 633.8 702.1 717.4 721.9 738.4 4448.0 4664.3 4667.8 4785.6 4822.8 81001.6 127176.0 127453.0 127606.0 129762.4 106311.9 106422.0 106797.0 108666.0 108710.5 93854.5 96701.5 97425.0 97473.5 101254.0 8921.6 8956.2 8987.0 8989.1 9026.4 56253.7 56406.4 57691.0 57763.0 57851.1 77380.6 79785.0 82835.6 83455.6 85741.0 12132.7 12139.4 12227.4 12377.9 12538.4 14073.6 14472.9 14657.9 15087.5 15571.9 12708.9 12786.9 12870.7 12877.7 13413.7 12995.2 13416.3 13774.3 14138.9 14766.9 12419.5 12428.3 12608.5 12651.7 12744.6 11290.2 11449.8 11457.0 11461.9 11499.4 10735.8 10744.5 11049.3 11069.3 11099.9 08:29:58 INFO - PROCESS | 28071 | -------- Summary: end -------- 08:29:58 INFO - PROCESS | 28071 | 08:29:59 INFO - TEST-INFO | 28071: exit 0 08:29:59 INFO - TEST-OK | dromaeo_css | took 1114288ms 08:29:59 INFO - TEST-START | kraken 08:29:59 INFO - operating with platform_type : linux_ 08:29:59 INFO - Initialising browser for kraken test... 08:29:59 INFO - TEST-INFO | started process 28256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpco8JAM/profile http://localhost:48348/getInfo.html) 08:30:03 INFO - PROCESS | 28256 | __metrics Screen width/height:1600/1200 08:30:03 INFO - PROCESS | 28256 | colorDepth:24 08:30:03 INFO - PROCESS | 28256 | Browser inner width/height: 1024/697 08:30:03 INFO - PROCESS | 28256 | __metrics 08:30:04 INFO - PROCESS | 28256 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:04 INFO - PROCESS | 28256 | console.error: PushService: 08:30:04 INFO - PROCESS | 28256 | stateChangeProcessEnqueue: Error transitioning state 08:30:04 INFO - PROCESS | 28256 | UnknownError 08:30:05 INFO - TEST-INFO | 28256: exit 0 08:30:05 INFO - Browser initialized. 08:30:05 INFO - Running cycle 1/1 for kraken test... 08:30:05 INFO - TEST-INFO | started process 28341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpco8JAM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:17 INFO - PROCESS | 28341 | RSS: Main: 174354432 08:30:17 INFO - PROCESS | 28341 | 08:30:20 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:20 INFO - PROCESS | 28341 | RSS: Main: 232275968 08:30:20 INFO - PROCESS | 28341 | 08:30:23 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-dft) 08:30:24 INFO - PROCESS | 28341 | RSS: Main: 220291072 08:30:24 INFO - PROCESS | 28341 | 08:30:27 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-fft) 08:30:27 INFO - PROCESS | 28341 | RSS: Main: 286085120 08:30:27 INFO - PROCESS | 28341 | 08:30:30 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-oscillator) 08:30:30 INFO - PROCESS | 28341 | RSS: Main: 197292032 08:30:30 INFO - PROCESS | 28341 | 08:30:32 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:33 INFO - PROCESS | 28341 | RSS: Main: 200794112 08:30:33 INFO - PROCESS | 28341 | 08:30:36 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:37 INFO - PROCESS | 28341 | RSS: Main: 236953600 08:30:37 INFO - PROCESS | 28341 | 08:30:40 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:41 INFO - PROCESS | 28341 | RSS: Main: 237694976 08:30:41 INFO - PROCESS | 28341 | 08:30:43 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48348/tests/kraken/driver.html?testName=json-parse-financial) 08:30:44 INFO - PROCESS | 28341 | RSS: Main: 237457408 08:30:44 INFO - PROCESS | 28341 | 08:30:46 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:46 INFO - PROCESS | 28341 | RSS: Main: 224313344 08:30:46 INFO - PROCESS | 28341 | 08:30:48 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:49 INFO - PROCESS | 28341 | RSS: Main: 229031936 08:30:49 INFO - PROCESS | 28341 | 08:30:51 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:51 INFO - PROCESS | 28341 | RSS: Main: 236351488 08:30:51 INFO - PROCESS | 28341 | 08:30:54 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:54 INFO - PROCESS | 28341 | RSS: Main: 239312896 08:30:54 INFO - PROCESS | 28341 | 08:30:57 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:58 INFO - PROCESS | 28341 | RSS: Main: 238878720 08:30:58 INFO - PROCESS | 28341 | 08:30:59 INFO - PROCESS | 28341 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48348/tests/kraken/driver.html?testName=ai-astar) 08:31:00 INFO - PROCESS | 28341 | RSS: Main: 281509888 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | __start_tp_report 08:31:00 INFO - PROCESS | 28341 | _x_x_mozilla_page_load 08:31:00 INFO - PROCESS | 28341 | _x_x_mozilla_page_load_details 08:31:00 INFO - PROCESS | 28341 | |i|pagename|runs| 08:31:00 INFO - PROCESS | 28341 | |0;ai-astar;103;110;111;114;111;109;110;109;107;108 08:31:00 INFO - PROCESS | 28341 | |1;audio-beat-detection;154;124;135;177;134;156;164;133;174;130 08:31:00 INFO - PROCESS | 28341 | |2;audio-dft;161;161;162;162;162;162;162;164;164;162 08:31:00 INFO - PROCESS | 28341 | |3;audio-fft;75;76;76;123;75;77;76;76;99;74 08:31:00 INFO - PROCESS | 28341 | |4;audio-oscillator;84;85;113;85;86;91;122;85;86;129 08:31:00 INFO - PROCESS | 28341 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;116;117 08:31:00 INFO - PROCESS | 28341 | |6;imaging-darkroom;145;146;145;145;146;146;146;146;145;145 08:31:00 INFO - PROCESS | 28341 | |7;imaging-desaturate;95;95;94;95;94;95;96;95;96;96 08:31:00 INFO - PROCESS | 28341 | |8;json-parse-financial;53;54;53;54;54;52;56;52;53;54 08:31:00 INFO - PROCESS | 28341 | |9;json-stringify-tinderbox;61;61;62;62;62;62;62;62;62;61 08:31:00 INFO - PROCESS | 28341 | |10;stanford-crypto-aes;79;81;77;78;78;81;79;80;90;78 08:31:00 INFO - PROCESS | 28341 | |11;stanford-crypto-ccm;121;120;129;121;129;127;126;133;147;122 08:31:00 INFO - PROCESS | 28341 | |12;stanford-crypto-pbkdf2;158;157;157;160;156;156;158;157;158;155 08:31:00 INFO - PROCESS | 28341 | |13;stanford-crypto-sha256-iterative;65;61;63;61;61;62;61;62;70;64 08:31:00 INFO - PROCESS | 28341 | __end_tp_report 08:31:00 INFO - PROCESS | 28341 | __start_cc_report 08:31:00 INFO - PROCESS | 28341 | _x_x_mozilla_cycle_collect,1602 08:31:00 INFO - PROCESS | 28341 | __end_cc_report 08:31:00 INFO - PROCESS | 28341 | __startTimestamp1467041460033__endTimestamp 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | ------- Summary: start ------- 08:31:00 INFO - PROCESS | 28341 | Number of tests: 14 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.90 (2.6%) stddev-sans-first:2.03 08:31:00 INFO - PROCESS | 28341 | Values: 103.0 110.0 111.0 114.0 111.0 109.0 110.0 109.0 107.0 108.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:155.00 stddev:19.33 (12.5%) stddev-sans-first:20.38 08:31:00 INFO - PROCESS | 28341 | Values: 154.0 124.0 135.0 177.0 134.0 156.0 164.0 133.0 174.0 130.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 08:31:00 INFO - PROCESS | 28341 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 162.0 164.0 164.0 162.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:15.97 (21.0%) stddev-sans-first:16.70 08:31:00 INFO - PROCESS | 28341 | Values: 75.0 76.0 76.0 123.0 75.0 77.0 76.0 76.0 99.0 74.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:17.58 (20.7%) stddev-sans-first:18.05 08:31:00 INFO - PROCESS | 28341 | Values: 84.0 85.0 113.0 85.0 86.0 91.0 122.0 85.0 86.0 129.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:31:00 INFO - PROCESS | 28341 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:31:00 INFO - PROCESS | 28341 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 08:31:00 INFO - PROCESS | 28341 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 96.0 95.0 96.0 96.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.18 (2.2%) stddev-sans-first:1.24 08:31:00 INFO - PROCESS | 28341 | Values: 53.0 54.0 53.0 54.0 54.0 52.0 56.0 52.0 53.0 54.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 08:31:00 INFO - PROCESS | 28341 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.73 (4.7%) stddev-sans-first:3.93 08:31:00 INFO - PROCESS | 28341 | Values: 79.0 81.0 77.0 78.0 78.0 81.0 79.0 80.0 90.0 78.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:128.00 stddev:8.09 (6.3%) stddev-sans-first:8.23 08:31:00 INFO - PROCESS | 28341 | Values: 121.0 120.0 129.0 121.0 129.0 127.0 126.0 133.0 147.0 122.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:1.40 (0.9%) stddev-sans-first:1.45 08:31:00 INFO - PROCESS | 28341 | Values: 158.0 157.0 157.0 160.0 156.0 156.0 158.0 157.0 158.0 155.0 08:31:00 INFO - PROCESS | 28341 | 08:31:00 INFO - PROCESS | 28341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.50 stddev:2.83 (4.5%) stddev-sans-first:2.91 08:31:00 INFO - PROCESS | 28341 | Values: 65.0 61.0 63.0 61.0 61.0 62.0 61.0 62.0 70.0 64.0 08:31:00 INFO - PROCESS | 28341 | -------- Summary: end -------- 08:31:00 INFO - PROCESS | 28341 | 08:31:01 INFO - TEST-INFO | 28341: exit 0 08:31:01 INFO - TEST-OK | kraken | took 61560ms 08:31:01 INFO - SUITE-END | took 1175s 08:31:01 INFO - Completed test suite (00:19:35) 08:31:01 INFO - javascript benchmark 08:31:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.7982531135476, 3104.3015321552666, 3119.313750974786, 3141.1361875484254, 3165.699258570435, 5170.53465188133, 5289.973550132244, 5303.787848486061, 5378.220158077076, 5394.703291318976, 5318.202269659553, 5351.785928562863, 5369.060414427479, 5379.731013449332, 5381.058314794915, 4821.541953514419, 4873.878153046185, 4895.363602731658, 4907.730074845882, 5042.621803364744, 4919.581835543983, 4920.778564964585, 5009.524095210949, 5035.597152227831, 5037.420696619899, 4619.861404157864, 4667.579917807379, 4821.758912054418, 4826.734529600871, 4908.067467181224, 4783.521647835189, 4815.301781241736, 4816.08494386069, 4871.342368780205, 4926.310316555685, 4847.830325938575, 4854.417469903634, 4863.416390033219, 4865.19724245499, 4896.632752543574, 5177.042247184283, 5287.180487024518, 5348.812791552277, 5357.276767636358, 5399.0, 5778.479936805666, 5791.21818554494, 5798.768049278024, 5818.738156782955, 5823.6505809651135, 5625.0, 5821.912671309934, 5854.326752423483, 5859.0, 5873.383294754075, 5327.573794096463, 5389.407165211824, 5397.217403476474, 5417.918731219035, 5472.5621950243885, 5939.198208241918, 5963.254593175853, 5965.075413310944, 5966.164736936832, 5967.791127310524, 5508.256385387921, 5701.116326969326, 5717.542596592262, 5721.971390143106, 5727.455891690282, 5671.120976248688, 5733.111367738007, 5745.368009518949, 5786.508146807569, 5787.797427090031, 5738.626989245686, 5777.19119323295, 5779.566532510079, 5787.276590426197, 5787.681677507778, 5498.230247765316, 5713.914291285634, 5783.88432231353, 5785.900678871001, 5789.797357092481, 4408.470983482002, 4427.557244275611, 4431.689781715313, 4465.687401881837, 4465.732056076581, 3933.4296527004, 3944.9605503945168, 3956.2878681837547, 3973.8807835764974, 3979.0, 5239.056969745482, 5289.100852855024, 5451.04606693827, 5458.863528411822, 5461.9453805461435, 5693.715314234271, 5708.286464191976, 5729.369769325371, 5760.711964401763, 5788.739506722208, 5396.757145928443, 5398.811041613525, 5409.350877894678, 5413.323334583177, 5414.972925135349, 4690.202665546865, 4798.976005119952, 4818.469968303484, 4828.203346447867, 4857.562819346276, 6036.124761909411, 6049.576529642883, 6050.455459008623, 6051.0, 6089.5737298388685, 5852.326982397079, 5863.120531920246, 5867.6772777497645, 5875.911861322169, 5876.559258055578, 5692.6299790513485, 5882.205902203319, 5942.078977758281, 5959.791407300723, 6032.819015429544, 5657.462541058593, 5676.7445464955, 5680.204771331934, 5685.658860468385, 5692.516136128475, 5713.8285851424525, 5729.054705973635, 5765.94234057654, 5786.276715410574, 5790.044642633919, 5437.102878025082, 5604.8038318658655, 5636.85907852307, 5661.773529058792, 5710.2291190690385, 5664.546836253007, 5678.233438485917, 5700.629459085146, 5710.057840456278, 5711.314642242957, 5294.0, 5609.635373700697, 5617.297837770278, 5621.184928185472, 5624.409437009219, 5528.7235638218735, 5548.916766248429, 5569.526590239875, 5658.434156584309, 5663.688497132697, 5404.486573775485, 5439.564834813126, 5446.509814116748, 5473.480019398151, 5476.3702174250475], "value": 5298.767044004383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4801922327575, 602.4969150759117, 606.4451027310012, 610.6397225636873, 622.8038167977084, 31320.0, 34064.0, 34292.82853585735, 43018.569814301845, 44222.7788861056, 45225.54774452255, 45729.7713511432, 45739.77130114353, 45839.31241031387, 46069.30896036562, 8891.199792018733, 9019.54902254888, 9035.457872527637, 9039.457632542035, 9045.140711632384, 8881.73354799357, 8961.641534338618, 8995.595198216064, 8996.100389961017, 8997.640094396216, 8990.68532601359, 8993.0, 9022.323325750562, 9033.23217526511, 9041.09589041094, 8989.190972812445, 9030.819383612357, 9040.321975851837, 9045.095490450967, 9045.547722613908, 8886.377953543255, 8909.55452227386, 8909.688160914402, 8925.776855578597, 8975.192232699088, 42850.571494284966, 43188.784056079516, 43255.56744432578, 43321.35017974733, 43420.565794341965, 3729.4778730977687, 3777.0557360659836, 3812.1041555234497, 3924.3132451820816, 4140.627343539096, 33152.17119572006, 33431.33137337264, 33581.832090839634, 34004.48993265103, 34140.14649633754, 4192.287311157111, 4195.349720793282, 4208.516020657602, 4265.125649241929, 4267.8079486423185, 363991.0, 365744.1712791446, 365897.0, 366401.0, 366574.0, 57992.420075798706, 58003.12995305074, 58118.70940645354, 58161.709191453774, 58172.12741808876, 54701.45298546964, 59023.40976590265, 59400.40599594035, 59769.41383517003, 60378.09432858511, 17300.394486192923, 17409.912950435166, 17438.215280312164, 17459.0, 17486.0, 13632.0, 13768.036237463482, 13786.931065344608, 13787.931060344834, 13795.10331828428, 14702.191379474018, 15750.448734294245, 16093.0, 16111.194440277939, 16256.187190640421, 5843.152742852262, 5903.203067585907, 5927.8221653350465, 5989.0, 6013.7895173669585, 949.8005418861978, 998.1615443027891, 1026.97432564185, 1067.754416484213, 1123.5393488669606, 32415.892966957545, 32839.671603284136, 32914.3417131656, 32986.0, 33260.334793304, 1125.8480105185695, 1136.7158210447387, 1151.988480115205, 1175.3946717440524, 1211.158245019703, 16938.915305423394, 17220.569485762957, 17340.393086241922, 17455.912720436572, 17488.825111748974, 567823.0, 571087.5782484327, 573701.0, 573849.0, 574075.0, 56297.43702562922, 57361.13958290629, 57582.0, 57612.711936440886, 57615.83112928745, 1230.1696354960545, 1322.490841026212, 1341.7316536692701, 1371.5268232459784, 1387.3756809435795, 32795.508067378534, 34109.0, 34396.31207375888, 34518.48222276718, 34711.631724240644, 49673.0, 50250.74874625603, 50355.49644503508, 50372.748136259084, 50428.0, 414237.0, 416921.0, 417743.5805135521, 418161.0, 418413.0, 36151.09622259464, 40948.0, 41174.79412603038, 42093.57906420896, 44461.0, 48639.0, 48894.0, 48959.0, 49441.0, 49711.75144124256, 40451.8939526248, 41454.1709165821, 41616.583834162484, 41654.95862603459, 41852.581474184866, 39939.60060399475, 40500.59499404968, 41405.79297103495, 41606.79196603998, 41828.58171418247, 41232.58767412287, 41325.38011929884, 42087.579124208365, 42403.1519369617, 42565.787171063945, 34453.48319775155, 36467.817660911525, 36691.26617467689, 36965.815170923976, 37231.0, 28141.437171256868, 28627.570586440805, 28667.0, 28861.422771544872, 28904.421911562073], "value": 20354.657592835516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.602461513871, 400.40739705236234, 406.14101176012736, 409.6824960655492, 412.5997782151312, 13063.869361306408, 18246.0, 19316.51708707283, 20073.0, 20110.89944550277, 14536.781948270758, 17553.912230438862, 18796.248150074014, 19205.807941920575, 19937.202511899544, 5609.607327487088, 5826.650400975955, 5842.6786526741225, 5854.297484301868, 5855.23881895353, 5778.855528611776, 5802.796902108427, 5833.620814647034, 5843.2695913010875, 5851.180834683148, 4162.687798415116, 6068.120122582223, 6366.0, 6378.138951241569, 6496.155499785022, 6178.289496707846, 6437.388448097447, 6439.678016099177, 6464.062710906939, 6467.579607325509, 5690.48785609293, 5706.28671416073, 5711.8000869969765, 5720.570957178186, 5727.083666613322, 22599.548009039892, 23687.289381318587, 24197.63703544448, 24270.757292427203, 24303.392415189584, 2464.8767561622026, 2505.3360859372283, 2673.919782406531, 2967.55486676998, 3043.9086827395213, 14251.78622320666, 14267.215303158322, 14709.779353309708, 14913.925430372887, 15251.23743812816, 1963.322653684491, 2001.1795163982697, 2031.3398145602591, 2045.417056139008, 2094.4345026842666, 79767.60116199382, 81353.59323203405, 82314.17685823125, 82352.58823705903, 83796.58101709452, 10349.534270957825, 10574.0, 10836.241463097665, 10971.177161712903, 11070.944645276722, 14960.775588366183, 15040.247987600576, 15059.548213553611, 15132.394704211709, 15171.848281517043, 8055.63749631268, 8089.433739638286, 8124.106348301682, 8166.754997350089, 8259.091499935003, 7826.726064587712, 8021.598920053974, 8080.515169089756, 8102.594870256464, 8259.42184047123, 5902.557308201902, 6222.595531290452, 6271.122042913996, 6568.638724870082, 6789.388954993976, 1824.7470169546903, 1927.7108433735052, 1941.805819418047, 1954.6774782160785, 1985.662437385648, 930.4649826349876, 993.3543196921914, 998.031909048222, 1046.0951277145214, 1116.213069785799, 19708.802911970983, 20250.392488225378, 20343.0, 20573.04556067171, 20715.689264661043, 994.1599348550463, 1019.4596863662271, 1027.7379268286688, 1027.9229057820694, 1038.6676263595577, 10304.742381440525, 11686.941565292289, 11737.471813768401, 11743.236689615147, 11753.236039657395, 494396.0, 510359.0, 512568.43715781183, 519587.0, 526074.0, 78488.0, 80519.19480805116, 81191.5940420294, 81353.18646813456, 82353.17646823575, 1004.1815920025156, 1037.8131936251548, 1062.1396668698378, 1067.4502631144967, 1075.188232884183, 18155.36456224026, 18171.273149073888, 18256.543586410447, 18330.17514211837, 18471.261149554404, 42036.15927681368, 42132.368014479194, 42430.0, 43047.35428968631, 43189.352159718255, 57040.71479642575, 58814.41185588089, 59862.0, 60217.69891150516, 61060.69469652801, 8227.71203007892, 8630.007549131678, 8697.782555436164, 8953.087965654271, 8973.865392018994, 9821.459819709984, 13722.0, 14312.499062532761, 14391.856081439051, 14411.85588144147, 12088.395580220778, 12113.878861211628, 12397.75204495923, 12475.438605262967, 12796.360181990676, 12070.939645301718, 12086.576969806014, 12107.334096624418, 12206.450709718261, 12514.311712855517, 12528.060395470195, 12568.622941311774, 12611.747765044463, 12712.555060573206, 12812.231266124063, 8548.358873084419, 8739.257163141205, 8806.0, 9038.367314287936, 9237.12247336502, 11676.70808229801, 11952.282863028246, 11973.401329933642, 12113.81829272544, 12127.0], "value": 9597.027802704613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.2248589603284, 1310.2727985967788, 1413.123863204813, 1441.7909403136546, 1682.806477255116, 8305.83388332233, 8734.606942687578, 8737.388382813198, 8964.193222609963, 9000.189982901538, 8762.561871906411, 8892.0, 8905.287576993842, 8941.15059069389, 8942.86585701215, 1946.8637195396327, 2016.2136766661015, 2023.959520809583, 2275.260540324393, 2310.2260742651233, 2277.943051423719, 2363.89362478688, 2364.562555927159, 2375.7743014413604, 2378.4767351182713, 2251.6735073414425, 2275.977240227601, 2279.6694479300572, 2296.0241897193628, 2297.3911913342977, 1957.7454930858896, 2164.9242276520245, 2281.3726225288015, 2282.851614645051, 2288.0275882749847, 2191.901364438604, 2221.389117992565, 2223.7331520217676, 2225.121077174507, 2227.6992605998144, 8946.910530894738, 8951.0, 8982.640694372218, 8989.730308090768, 9001.279897608176, 5114.130597798383, 5254.737263136866, 5257.395399529065, 5259.658122222043, 5262.368515778093, 3149.291409432882, 3272.7709060365783, 3297.241634424096, 3333.9498058111617, 3388.2376465295356, 1095.2257343104143, 1099.7745462180235, 1105.2594761509808, 1110.566878917223, 1121.8373335866254, 12698.619041428772, 12709.618711438672, 12718.682032949158, 12728.1726687765, 12728.490860365575, 4543.522930092358, 4544.113897789899, 4646.4191976003, 4660.254359302563, 4662.6269898408045, 10714.946425267824, 10725.78548429027, 10726.088282496075, 10737.033666969854, 10743.78512429747, 5293.338332708411, 5298.231756395301, 5298.602604804578, 5307.4692530746615, 5308.46915308466, 4115.382692596135, 4692.7653617319, 4824.179889418807, 4876.829310974099, 4947.777350019258, 4017.1764788218347, 4042.514898212233, 4088.1823635273063, 4141.544430112685, 4175.06061136248, 1212.9454174562165, 1242.3974372429363, 1244.2161438293997, 1244.7821631214683, 1282.6280378690076, 822.6873787960536, 826.8304997475503, 913.6528119314618, 928.5821380378857, 956.2015716876347, 5740.68426236561, 5812.38969908162, 5880.382559831156, 5942.554308426886, 5989.1914591529585, 977.8266080703185, 983.5573991703762, 1008.7189269627679, 1012.64051261801, 1014.1278500489573, 3926.6662333701383, 4065.735727177724, 4073.7759423232005, 4083.7549747015273, 4137.793110344471, 10952.178586606036, 11142.331460112257, 11218.607348742918, 11345.829812552818, 11395.202335836411, 10893.237473376947, 11076.390798505998, 11128.554857805759, 11199.888001120047, 11205.04757095656, 8370.539620320818, 8485.915140848636, 8485.95757021211, 8506.234438900528, 8520.786980325418, 5689.54483641316, 5918.822435326947, 5923.644581325134, 5960.523158147251, 5972.134040564007, 10128.442935638315, 10336.759588849387, 10360.274780765274, 10370.27408081427, 10496.05535501778, 10470.790584188426, 10476.440386776616, 10557.788844223227, 10600.0989915858, 10750.623728169476, 6999.685014174476, 7419.591922444318, 7654.425918056057, 7664.31021208094, 7786.182450842806, 8961.596728147379, 9007.324450666358, 9039.548022598712, 9046.321525885453, 9055.094490550891, 7897.605119743875, 8048.678052877819, 8105.473144245605, 8146.429749917449, 8240.876386854083, 7658.081030276402, 7846.450748447553, 7886.802829929297, 7918.089419716806, 8055.3152981994845, 7365.705371785069, 7395.408367330493, 7396.889046664412, 7490.475666703279, 7505.211952744883, 5158.09733296679, 5232.869178270422, 5238.580913526985, 5249.2126181073145, 5292.920606190987, 4810.39870016248, 4870.0, 4877.365942427462, 5003.374578177728, 5101.9489805101475], "value": 4640.986898429906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.64495283183766, 300.10269294808523, 304.9939001219975, 308.1495073596872, 308.7098127759907, 5077.492250774921, 5123.53979115952, 5164.638475306725, 5210.010098081367, 5221.190715439104, 5148.8929880075775, 5188.792448302072, 5200.817971371002, 5214.165733482643, 5226.686398816074, 4016.4778578784717, 4022.235775202702, 4022.3162062449305, 4046.3525835866267, 4055.1889622075705, 3812.1613245086037, 3862.1310205203886, 4016.15660711251, 4027.2750904837117, 4032.1129351542613, 4011.438398624195, 4042.0, 4057.4928133983253, 4059.1678705865374, 4064.796760161995, 4020.4170395292663, 4033.9193216135805, 4035.515738111416, 4041.2725709372303, 4070.903484705379, 3509.5963964144194, 3571.5892672342493, 3580.606133325332, 3593.1915319053264, 3593.5508061492314, 5072.213806859942, 5076.517730815566, 5085.211792172219, 5093.414257360414, 5110.386753589593, 4543.750093744843, 4631.1895418301665, 4637.420322459692, 4639.304104384336, 4654.162250794856, 5230.581553475751, 5443.2107344435235, 5444.292242008513, 5450.75679970421, 5465.152901300305, 3879.7478163919536, 3899.3566061599804, 3909.0618251619408, 3913.5499417566775, 3942.6792024671768, 5656.208130861683, 5683.204351390808, 5693.0, 5711.657300561979, 5714.914276285859, 4038.8788336349958, 4045.6358927696647, 4049.7165198436414, 4052.2908491013955, 4071.4096456014304, 3909.863154789569, 4011.438398624195, 4020.8391664333685, 4023.3562629979065, 4028.8992775180855, 4566.3150527420485, 4598.149342371672, 4611.492735799059, 4620.168369693488, 4629.560191781776, 5367.731613419313, 5388.164834450667, 5495.230667706524, 5502.449755024546, 5547.585365731713, 1274.898008159345, 1304.1132030219542, 1381.599336192513, 1386.8766299297602, 1387.9167249965035, 880.7093659092484, 889.9110088991049, 890.7218141966299, 899.8965119011398, 922.3036607361399, 4647.651426143053, 4667.883302917454, 4686.320483529869, 4689.60138388234, 4691.780137164294, 4889.193283108319, 4955.231939049453, 4965.553100220997, 4971.141593583631, 5005.874853128628, 4613.261878099555, 4621.815127394933, 4665.5567721066445, 4711.552402521755, 4722.244440889442, 2749.6150538924567, 2981.1652737233608, 2990.5065664165168, 3008.669046404894, 3013.3426615361464, 5802.912956305659, 5821.962313190349, 5863.299643103453, 5895.757333466576, 5908.291005079418, 5521.475459831309, 5645.943540564624, 5667.801626943037, 5793.798356624456, 5808.680522571299, 5766.279215098113, 5787.565932554991, 5801.042827933344, 5807.157962095473, 5835.679037652885, 5618.831435056954, 5657.830265092054, 5658.688772117573, 5663.830085097454, 5669.299210236995, 5305.204219367126, 5587.6088673794075, 5602.691851948182, 5608.523275521463, 5641.545927521542, 5829.417058294306, 5849.94150058494, 5867.9413205869105, 5868.3251426086545, 5906.26171728534, 3863.5704789228166, 3878.9268697732527, 3915.9021024474614, 3924.843006279717, 3946.8223929923797, 5617.859553511032, 5622.746976385991, 5636.661800291996, 5655.2648155741135, 5657.660540367591, 5483.506484416422, 5508.421615730291, 5525.364583072998, 5595.832125036255, 5596.377050655265, 5301.8144364948585, 5523.28197334344, 5528.530074943675, 5580.358258800127, 5612.354579223442, 5413.106837371947, 5414.485623865727, 5423.806762512241, 5452.372977107683, 5501.779928802803, 5582.27430434041, 5609.513478928169, 5615.7192140392, 5621.578381621313, 5634.492895639412, 5188.533032027136, 5445.50990410865, 5452.509274165344, 5467.152591348347, 5469.644473109235], "value": 4116.627518816053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.4995877741302, 768.0246087468918, 769.460779427888, 797.3700776386655, 828.1801016993177, 13939.233342166177, 14677.266136693162, 14685.265736713149, 14694.0, 14702.63243418915, 12613.810792838114, 13603.319834008309, 13695.520656777015, 13713.0, 13725.107867988574, 670.1054092786112, 785.5993443343893, 786.7521730654854, 800.5556915911667, 807.9757607271791, 797.5493845977004, 801.3829351399419, 802.1016461563057, 802.1096582793095, 802.3019972623825, 847.2374862623626, 848.4951453884929, 854.2311919272643, 854.8717692346166, 854.8760429737684, 699.3810477727197, 810.6473683947472, 827.1067247372823, 828.0022572799762, 849.6558893648051, 606.1120458528234, 606.648144076439, 607.1105829959087, 607.1894021481328, 608.528390497368, 13149.0, 13183.604491865259, 13196.604101876863, 13203.471861125543, 13206.603801885958, 13079.542216022488, 13236.669083272898, 13302.068855180141, 13479.123856949267, 13650.180989140585, 12897.226166430044, 12998.155119917175, 13046.804297935538, 13258.403371848193, 13401.128926619836, 4601.7699115044115, 4634.060293467318, 4703.247480403119, 4712.764361781898, 4736.218523943545, 72236.63881680611, 72277.0, 74427.0, 75253.0, 76330.61834690846, 11197.832032519518, 11329.263597866113, 11360.943195283971, 11408.272671406381, 11544.538218471334, 19660.21359145618, 20380.490487737927, 20408.591828163353, 20413.285535006202, 20420.795792042187, 8599.699010534601, 8675.869861952076, 8757.255633271116, 8776.254018408506, 8885.866711999326, 4798.5441383068555, 4847.660663753503, 4869.537393947569, 4993.2010878260035, 5079.6952182869145, 3044.74119699828, 3150.5431712402033, 3181.3955348483714, 3181.4750566156786, 3186.4105140549073, 561.7809054468761, 574.6178791103869, 586.8268860686107, 593.1666009256915, 628.7579281976381, 681.4922882452605, 682.8361193313569, 730.7844185965153, 749.3742724824723, 789.1753117991713, 9445.622175113056, 9638.518074096268, 9782.364146330608, 9899.703008909744, 10018.3488073275, 633.7908490198223, 702.1468915267974, 717.4117223876475, 721.9025431566671, 738.3908275672592, 4448.0, 4664.346991421204, 4667.8366257181515, 4785.569298763058, 4822.7829747661435, 81001.59499202466, 127176.0, 127453.0, 127606.0, 129762.35118824345, 106311.93688063175, 106422.0, 106797.0, 108666.0, 108710.45644771725, 93854.53072734593, 96701.5164924185, 97425.0, 97473.5126324378, 101254.0, 8921.598528066383, 8956.238719708897, 8987.0, 8989.101089890959, 9026.368154229142, 56253.71873140608, 56406.43593564012, 57691.0, 57763.0, 57851.1322330157, 77380.6130969364, 79785.0, 82835.5858220705, 83455.582722086, 85741.0, 12132.696682583006, 12139.393030348623, 12227.388630568257, 12377.938110309751, 12538.435770390537, 14073.648158796112, 14472.855271447152, 14657.853421465648, 15087.4719384821, 15571.922140389226, 12708.87291127077, 12786.936065319614, 12870.678233043875, 12877.678058048623, 13413.66465838362, 12995.155314904501, 13416.32918354098, 13774.332643752328, 14138.929305353407, 14766.926165369105, 12419.503219871465, 12428.316442595382, 12608.49566017349, 12651.746965060463, 12744.553940612033, 11290.209685322277, 11449.828252576384, 11457.0, 11461.885381146081, 11499.425028748696, 10735.838962415413, 10744.51649675782, 11049.28179668319, 11069.280496767684, 11099.94450027777], "value": 7526.598322404924, "unit": "score"}], "name": "dromaeo_css", "value": 7279.958476571388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 114.0, 111.0, 109.0, 110.0, 109.0, 107.0, 108.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 135.0, 177.0, 134.0, 156.0, 164.0, 133.0, 174.0, 130.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 164.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 123.0, 75.0, 77.0, 76.0, 76.0, 99.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 85.0, 86.0, 91.0, 122.0, 85.0, 86.0, 129.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 54.0, 52.0, 56.0, 52.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 77.0, 78.0, 78.0, 81.0, 79.0, 80.0, 90.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 129.0, 121.0, 129.0, 127.0, 126.0, 133.0, 147.0, 122.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 157.0, 160.0, 156.0, 156.0, 158.0, 157.0, 158.0, 155.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 63.0, 61.0, 61.0, 62.0, 61.0, 62.0, 70.0, 64.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1499.1, "alertThreshold": 2.0}]} 08:31:01 INFO - Return code: 0 08:31:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:01 INFO - # TBPL SUCCESS # 08:31:01 INFO - Running post-action listener: _resource_record_post_action 08:31:01 INFO - ##### 08:31:01 INFO - ##### Finished run-tests step (success) 08:31:01 INFO - ##### 08:31:01 INFO - Running post-run listener: _resource_record_post_run 08:31:01 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 551133184; Read time: 0; Write time: 476456 08:31:01 INFO - TinderboxPrint: CPU usage
13.1% 08:31:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:31:01 INFO - TinderboxPrint: I/O write bytes / time
551,133,184 / 476,456 08:31:01 INFO - TinderboxPrint: CPU idle
8,274.8 (86.8%) 08:31:01 INFO - TinderboxPrint: CPU user
1,204.1 (12.6%) 08:31:01 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257073152; Read time: 0; Write time: 295068 08:31:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294060032; Read time: 0; Write time: 181388 08:31:01 INFO - Running post-run listener: _upload_blobber_files 08:31:01 INFO - Blob upload gear active. 08:31:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:01 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 08:31:01 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:31:01 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:31:02 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:05 INFO - (blobuploader) - INFO - Done attempting. 08:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:06 INFO - (blobuploader) - INFO - Done attempting. 08:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:07 INFO - (blobuploader) - INFO - Done attempting. 08:31:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:07 INFO - Return code: 0 08:31:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dd88a4e13019e924c1c71c9e76283d80b2a018cf60666d527bfabfde294ac2701d3c133cbe2ac084c0ed42645f09846db632515b54376ec40812f3408ac5f05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b9ed43a0fe7972104839ebb4bd5fc3815b6fe588ad8d49316ce5d5cbca5beefbac89f059a848d9d197b30a91b20a5c4bd489badb0b583092dfaee736147b1bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7357d96d2ebe01082509447bc6c59ae541f4b070a01ed23065ee9420859afaac7c632d2675770dbcccd0739e8658e7cfc311693c6df2a912259589c2abd59d69"} 08:31:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:07 INFO - Contents: 08:31:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dd88a4e13019e924c1c71c9e76283d80b2a018cf60666d527bfabfde294ac2701d3c133cbe2ac084c0ed42645f09846db632515b54376ec40812f3408ac5f05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b9ed43a0fe7972104839ebb4bd5fc3815b6fe588ad8d49316ce5d5cbca5beefbac89f059a848d9d197b30a91b20a5c4bd489badb0b583092dfaee736147b1bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7357d96d2ebe01082509447bc6c59ae541f4b070a01ed23065ee9420859afaac7c632d2675770dbcccd0739e8658e7cfc311693c6df2a912259589c2abd59d69"} 08:31:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:07 INFO - Copying logs to upload dir... 08:31:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.174990 ========= master_lag: 12.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-27 08:31:19.168960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:31:19.172976) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6dd88a4e13019e924c1c71c9e76283d80b2a018cf60666d527bfabfde294ac2701d3c133cbe2ac084c0ed42645f09846db632515b54376ec40812f3408ac5f05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b9ed43a0fe7972104839ebb4bd5fc3815b6fe588ad8d49316ce5d5cbca5beefbac89f059a848d9d197b30a91b20a5c4bd489badb0b583092dfaee736147b1bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7357d96d2ebe01082509447bc6c59ae541f4b070a01ed23065ee9420859afaac7c632d2675770dbcccd0739e8658e7cfc311693c6df2a912259589c2abd59d69"} build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/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/Fx-Team/sha512/6dd88a4e13019e924c1c71c9e76283d80b2a018cf60666d527bfabfde294ac2701d3c133cbe2ac084c0ed42645f09846db632515b54376ec40812f3408ac5f05", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b9ed43a0fe7972104839ebb4bd5fc3815b6fe588ad8d49316ce5d5cbca5beefbac89f059a848d9d197b30a91b20a5c4bd489badb0b583092dfaee736147b1bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7357d96d2ebe01082509447bc6c59ae541f4b070a01ed23065ee9420859afaac7c632d2675770dbcccd0739e8658e7cfc311693c6df2a912259589c2abd59d69"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:31:19.209298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:31:19.215198) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467039427.847171-195862091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 1.72 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:31:20.943821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:31:20.944168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:31:20.945422) ========= ========= Total master_lag: 14.21 =========