builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1465603418.99 results: success (0) buildid: 20160610143003 builduid: de4e95ddd121469daab36eaa8df50faf revision: 9545df18ca9eaa35915df14e23543c02363ff83e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:38.992059) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:38.999713) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:38.999999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.036734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.037014) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 17:03:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-06-10 17:03:39 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119025 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.169668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.169978) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.219661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.220014) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9545df18ca9eaa35915df14e23543c02363ff83e --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 9545df18ca9eaa35915df14e23543c02363ff83e --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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 17:03:39,688 truncating revision to first 12 chars 2016-06-10 17:03:39,688 Setting DEBUG logging. 2016-06-10 17:03:39,688 attempt 1/10 2016-06-10 17:03:39,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9545df18ca9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 17:03:40,086 unpacking tar archive at: fx-team-9545df18ca9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732102 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.965753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.966080) ========= script_repo_revision: 9545df18ca9eaa35915df14e23543c02363ff83e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.966506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.966780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 17:03:39.977572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-10 17:03:39.977938) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:40 INFO - MultiFileLogger online at 20160610 17:03:40 in /builds/slave/test 17:03:40 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 17:03:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:40 INFO - {'append_to_log': False, 17:03:40 INFO - 'base_work_dir': '/builds/slave/test', 17:03:40 INFO - 'blob_upload_branch': 'Fx-Team', 17:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:40 INFO - 'branch': 'Fx-Team', 17:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:40 INFO - 'config_files': ('talos/linux_config.py',), 17:03:40 INFO - 'default_actions': ('clobber', 17:03:40 INFO - 'read-buildbot-config', 17:03:40 INFO - 'download-and-extract', 17:03:40 INFO - 'populate-webroot', 17:03:40 INFO - 'create-virtualenv', 17:03:40 INFO - 'install', 17:03:40 INFO - 'run-tests'), 17:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:40 INFO - 'download_minidump_stackwalk': True, 17:03:40 INFO - 'download_symbols': 'ondemand', 17:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:40 INFO - 'installer_path': 'installer.exe', 17:03:40 INFO - 'log_level': 'info', 17:03:40 INFO - 'log_name': 'talos', 17:03:40 INFO - 'log_to_console': True, 17:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:40 INFO - 'opt_config_files': (), 17:03:40 INFO - 'pip_index': False, 17:03:40 INFO - 'sps_profile': False, 17:03:40 INFO - 'sps_profile_interval': 0, 17:03:40 INFO - 'suite': 'dromaeojs', 17:03:40 INFO - 'system_bits': '32', 17:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:40 INFO - 'title': 'talos-linux64-ix-042', 17:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:40 INFO - 'use_talos_json': True, 17:03:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:40 INFO - 'work_dir': 'build'} 17:03:40 INFO - ##### 17:03:40 INFO - ##### Running clobber step. 17:03:40 INFO - ##### 17:03:40 INFO - Running pre-action listener: _resource_record_pre_action 17:03:40 INFO - Running main action method: clobber 17:03:40 INFO - rmtree: /builds/slave/test/build 17:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:41 INFO - Running post-action listener: _resource_record_post_action 17:03:41 INFO - ##### 17:03:41 INFO - ##### Finished clobber step (success) 17:03:41 INFO - ##### 17:03:41 INFO - ##### 17:03:41 INFO - ##### Running read-buildbot-config step. 17:03:41 INFO - ##### 17:03:41 INFO - Running pre-action listener: _resource_record_pre_action 17:03:41 INFO - Running main action method: read_buildbot_config 17:03:41 INFO - Using buildbot properties: 17:03:41 INFO - { 17:03:41 INFO - "project": "", 17:03:41 INFO - "product": "firefox", 17:03:41 INFO - "script_repo_revision": "production", 17:03:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:03:41 INFO - "repository": "", 17:03:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:03:41 INFO - "buildid": "20160610143003", 17:03:41 INFO - "pgo_build": "True", 17:03:41 INFO - "basedir": "/builds/slave/test", 17:03:41 INFO - "buildnumber": 1246, 17:03:41 INFO - "slavename": "talos-linux64-ix-042", 17:03:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:03:41 INFO - "platform": "ubuntu64_hw", 17:03:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:03:41 INFO - "branch": "fx-team", 17:03:41 INFO - "repo_path": "integration/fx-team", 17:03:41 INFO - "revision": "9545df18ca9eaa35915df14e23543c02363ff83e", 17:03:41 INFO - "stage_platform": "linux64-pgo", 17:03:41 INFO - "builduid": "de4e95ddd121469daab36eaa8df50faf", 17:03:41 INFO - "slavebuilddir": "test" 17:03:41 INFO - } 17:03:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:03:41 INFO - Running post-action listener: _resource_record_post_action 17:03:41 INFO - ##### 17:03:41 INFO - ##### Finished read-buildbot-config step (success) 17:03:41 INFO - ##### 17:03:41 INFO - ##### 17:03:41 INFO - ##### Running download-and-extract step. 17:03:41 INFO - ##### 17:03:41 INFO - Running pre-action listener: _resource_record_pre_action 17:03:41 INFO - Running main action method: download_and_extract 17:03:41 INFO - mkdir: /builds/slave/test/build/tests 17:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:41 INFO - https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:03:42 INFO - Downloaded 1361 bytes. 17:03:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:03:42 INFO - Using the following test package requirements: 17:03:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:03:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'jsshell-linux-x86_64.zip'], 17:03:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:42 INFO - https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:52 INFO - Downloaded 24464391 bytes. 17:03:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:03:54 INFO - Return code: 0 17:03:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:54 INFO - https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:03:55 INFO - Downloaded 24464391 bytes. 17:03:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:03:56 INFO - Return code: 0 17:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:56 INFO - https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:03:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:03:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:03:57 INFO - Downloaded 10833377 bytes. 17:03:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:03:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:03:58 INFO - Return code: 0 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:58 INFO - https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:03:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:03:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:03:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:03:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:03:59 INFO - Downloaded 59362563 bytes. 17:03:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:03:59 INFO - mkdir: /builds/slave/test/properties 17:03:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:59 INFO - Contents: 17:03:59 INFO - build_url:https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:04:00 INFO - Running post-action listener: _resource_record_post_action 17:04:00 INFO - Running post-action listener: set_extra_try_arguments 17:04:00 INFO - ##### 17:04:00 INFO - ##### Finished download-and-extract step (success) 17:04:00 INFO - ##### 17:04:00 INFO - ##### 17:04:00 INFO - ##### Running populate-webroot step. 17:04:00 INFO - ##### 17:04:00 INFO - Running pre-action listener: _resource_record_pre_action 17:04:00 INFO - Running main action method: populate_webroot 17:04:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:00 INFO - '--tppagecycles', 17:04:00 INFO - '7'], 17:04:00 INFO - 'tests': ['tsvgm']}}, 17:04:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:04:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:04:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:04:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['damp', 'tps']}, 17:04:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'tests': ['damp', 'tps']}, 17:04:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['dromaeo_dom']}, 17:04:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['a11yr', 17:04:00 INFO - 'ts_paint', 17:04:00 INFO - 'tpaint', 17:04:00 INFO - 'sessionrestore', 17:04:00 INFO - 'sessionrestore_no_auto_restore', 17:04:00 INFO - 'tabpaint']}, 17:04:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['tsvgx', 17:04:00 INFO - 'tsvgr_opacity', 17:04:00 INFO - 'tart', 17:04:00 INFO - 'tscrollx', 17:04:00 INFO - 'cart']}, 17:04:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:04:00 INFO - 'tsvgr_opacity', 17:04:00 INFO - 'tart', 17:04:00 INFO - 'tscrollx', 17:04:00 INFO - 'cart']}, 17:04:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'talos_options': ['--disable-e10s'], 17:04:00 INFO - 'tests': ['tp5o']}, 17:04:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'tests': ['tp5o']}, 17:04:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'talos_options': ['--disable-e10s', 17:04:00 INFO - '--xperf_path', 17:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:00 INFO - 'tests': ['tp5n']}, 17:04:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:00 INFO - 'talos_options': ['--xperf_path', 17:04:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:00 INFO - 'tests': ['tp5n']}}, 17:04:00 INFO - 'talos.zip': {'path': '', 17:04:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:00 INFO - Running post-action listener: _resource_record_post_action 17:04:00 INFO - ##### 17:04:00 INFO - ##### Finished populate-webroot step (success) 17:04:00 INFO - ##### 17:04:00 INFO - ##### 17:04:00 INFO - ##### Running create-virtualenv step. 17:04:00 INFO - ##### 17:04:00 INFO - Running pre-action listener: _resource_record_pre_action 17:04:00 INFO - Running main action method: create_virtualenv 17:04:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:04:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:00 INFO - Using real prefix '/usr' 17:04:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:03 INFO - Installing pip.................done. 17:04:03 INFO - Return code: 0 17:04:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04: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', 'pip>=1.5'] in /builds/slave/test/build 17:04: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 pip>=1.5 17:04:03 INFO - Using env: {'DISPLAY': ':0', 17:04:03 INFO - 'HOME': '/home/cltbld', 17:04:03 INFO - 'LANG': 'en_US.UTF-8', 17:04:03 INFO - 'LANGUAGE': 'en_US:en', 17:04:03 INFO - 'LOGNAME': 'cltbld', 17:04:03 INFO - 'MAIL': '/var/mail/cltbld', 17:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:03 INFO - 'MOZ_NO_REMOTE': '1', 17:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:03 INFO - 'NO_EM_RESTART': '1', 17:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:03 INFO - 'PWD': '/builds/slave/test', 17:04:03 INFO - 'SHELL': '/bin/bash', 17:04:03 INFO - 'SHLVL': '1', 17:04:03 INFO - 'TERM': 'linux', 17:04:03 INFO - 'TMOUT': '86400', 17:04:03 INFO - 'USER': 'cltbld', 17:04:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:03 INFO - '_': '/tools/buildbot/bin/python'} 17:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:04:03 INFO - Cleaning up... 17:04:03 INFO - Return code: 0 17:04:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', '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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:04: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 psutil>=3.1.1 17:04:03 INFO - Using env: {'DISPLAY': ':0', 17:04:03 INFO - 'HOME': '/home/cltbld', 17:04:03 INFO - 'LANG': 'en_US.UTF-8', 17:04:03 INFO - 'LANGUAGE': 'en_US:en', 17:04:03 INFO - 'LOGNAME': 'cltbld', 17:04:03 INFO - 'MAIL': '/var/mail/cltbld', 17:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:03 INFO - 'MOZ_NO_REMOTE': '1', 17:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:03 INFO - 'NO_EM_RESTART': '1', 17:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:03 INFO - 'PWD': '/builds/slave/test', 17:04:03 INFO - 'SHELL': '/bin/bash', 17:04:03 INFO - 'SHLVL': '1', 17:04:03 INFO - 'TERM': 'linux', 17:04:03 INFO - 'TMOUT': '86400', 17:04:03 INFO - 'USER': 'cltbld', 17:04:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:03 INFO - '_': '/tools/buildbot/bin/python'} 17:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:03 INFO - Downloading/unpacking psutil>=3.1.1 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:05 INFO - Installing collected packages: psutil 17:04:05 INFO - Running setup.py install for psutil 17:04:05 INFO - building 'psutil._psutil_linux' extension 17:04:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:04:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:04:06 INFO - building 'psutil._psutil_posix' extension 17:04:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:04:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:06 INFO - Successfully installed psutil 17:04:06 INFO - Cleaning up... 17:04:06 INFO - Return code: 0 17:04:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:06 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:04:06 INFO - Using env: {'DISPLAY': ':0', 17:04:06 INFO - 'HOME': '/home/cltbld', 17:04:06 INFO - 'LANG': 'en_US.UTF-8', 17:04:06 INFO - 'LANGUAGE': 'en_US:en', 17:04:06 INFO - 'LOGNAME': 'cltbld', 17:04:06 INFO - 'MAIL': '/var/mail/cltbld', 17:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:06 INFO - 'MOZ_NO_REMOTE': '1', 17:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:06 INFO - 'NO_EM_RESTART': '1', 17:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:06 INFO - 'PWD': '/builds/slave/test', 17:04:06 INFO - 'SHELL': '/bin/bash', 17:04:06 INFO - 'SHLVL': '1', 17:04:06 INFO - 'TERM': 'linux', 17:04:06 INFO - 'TMOUT': '86400', 17:04:06 INFO - 'USER': 'cltbld', 17:04:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:06 INFO - '_': '/tools/buildbot/bin/python'} 17:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:04:08 INFO - Installing collected packages: mozsystemmonitor 17:04:08 INFO - Running setup.py install for mozsystemmonitor 17:04:08 INFO - Successfully installed mozsystemmonitor 17:04:08 INFO - Cleaning up... 17:04:08 INFO - Return code: 0 17:04:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:08 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:04:08 INFO - Using env: {'DISPLAY': ':0', 17:04:08 INFO - 'HOME': '/home/cltbld', 17:04:08 INFO - 'LANG': 'en_US.UTF-8', 17:04:08 INFO - 'LANGUAGE': 'en_US:en', 17:04:08 INFO - 'LOGNAME': 'cltbld', 17:04:08 INFO - 'MAIL': '/var/mail/cltbld', 17:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:08 INFO - 'MOZ_NO_REMOTE': '1', 17:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:08 INFO - 'NO_EM_RESTART': '1', 17:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:08 INFO - 'PWD': '/builds/slave/test', 17:04:08 INFO - 'SHELL': '/bin/bash', 17:04:08 INFO - 'SHLVL': '1', 17:04:08 INFO - 'TERM': 'linux', 17:04:08 INFO - 'TMOUT': '86400', 17:04:08 INFO - 'USER': 'cltbld', 17:04:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:08 INFO - '_': '/tools/buildbot/bin/python'} 17:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:08 INFO - Downloading/unpacking jsonschema==2.5.1 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:10 INFO - warning: no files found matching '*.txt' 17:04:10 INFO - no previously-included directories found matching 'build' 17:04:10 INFO - no previously-included directories found matching 'dist' 17:04:10 INFO - no previously-included directories found matching '.git*' 17:04:10 INFO - Installing collected packages: jsonschema, functools32 17:04:10 INFO - Running setup.py install for functools32 17:04:11 INFO - warning: no files found matching '*.txt' 17:04:11 INFO - no previously-included directories found matching 'build' 17:04:11 INFO - no previously-included directories found matching 'dist' 17:04:11 INFO - no previously-included directories found matching '.git*' 17:04:11 INFO - Successfully installed jsonschema functools32 17:04:11 INFO - Cleaning up... 17:04:11 INFO - Return code: 0 17:04:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:04:11 INFO - Using env: {'DISPLAY': ':0', 17:04:11 INFO - 'HOME': '/home/cltbld', 17:04:11 INFO - 'LANG': 'en_US.UTF-8', 17:04:11 INFO - 'LANGUAGE': 'en_US:en', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MAIL': '/var/mail/cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SHLVL': '1', 17:04:11 INFO - 'TERM': 'linux', 17:04:11 INFO - 'TMOUT': '86400', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - '_': '/tools/buildbot/bin/python'} 17:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:11 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:14 INFO - Downloading docopt-0.6.1.tar.gz 17:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:14 INFO - Running setup.py install for blobuploader 17:04:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:14 INFO - Running setup.py install for requests 17:04:14 INFO - Running setup.py install for docopt 17:04:14 INFO - Successfully installed blobuploader requests docopt 17:04:14 INFO - Cleaning up... 17:04:14 INFO - Return code: 0 17:04:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:14 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:14 INFO - Using env: {'DISPLAY': ':0', 17:04:14 INFO - 'HOME': '/home/cltbld', 17:04:14 INFO - 'LANG': 'en_US.UTF-8', 17:04:14 INFO - 'LANGUAGE': 'en_US:en', 17:04:14 INFO - 'LOGNAME': 'cltbld', 17:04:14 INFO - 'MAIL': '/var/mail/cltbld', 17:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:14 INFO - 'MOZ_NO_REMOTE': '1', 17:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:14 INFO - 'NO_EM_RESTART': '1', 17:04:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:14 INFO - 'PWD': '/builds/slave/test', 17:04:14 INFO - 'SHELL': '/bin/bash', 17:04:14 INFO - 'SHLVL': '1', 17:04:14 INFO - 'TERM': 'linux', 17:04:14 INFO - 'TMOUT': '86400', 17:04:14 INFO - 'USER': 'cltbld', 17:04:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:14 INFO - '_': '/tools/buildbot/bin/python'} 17:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:14 INFO - Running setup.py (path:/tmp/pip-h08W7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:15 INFO - Running setup.py (path:/tmp/pip-Grnmq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:15 INFO - Running setup.py (path:/tmp/pip-qmy1WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:15 INFO - Running setup.py (path:/tmp/pip-0bU2hR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:15 INFO - Running setup.py (path:/tmp/pip-KBNF7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:15 INFO - Running setup.py (path:/tmp/pip-iqlYM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:15 INFO - Running setup.py (path:/tmp/pip-mbbYqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:15 INFO - Running setup.py (path:/tmp/pip-VtQyPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:15 INFO - Running setup.py (path:/tmp/pip-OS4ITI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:15 INFO - Running setup.py (path:/tmp/pip-kpmUOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:15 INFO - Running setup.py (path:/tmp/pip-RbXOgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:15 INFO - Running setup.py (path:/tmp/pip-wxFdrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:15 INFO - Running setup.py (path:/tmp/pip-6KuYRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:15 INFO - Running setup.py (path:/tmp/pip-oLNNl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:15 INFO - Running setup.py (path:/tmp/pip-frcsrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:16 INFO - Running setup.py (path:/tmp/pip-MxNyZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:16 INFO - Running setup.py (path:/tmp/pip-Ol2_Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:16 INFO - Running setup.py install for manifestparser 17:04:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Running setup.py install for mozcrash 17:04:16 INFO - Running setup.py install for mozdebug 17:04:16 INFO - Running setup.py install for mozdevice 17:04:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Running setup.py install for mozfile 17:04:16 INFO - Running setup.py install for mozhttpd 17:04:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Running setup.py install for mozinfo 17:04:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Running setup.py install for mozInstall 17:04:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:16 INFO - Running setup.py install for mozleak 17:04:17 INFO - Running setup.py install for mozlog 17:04:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Running setup.py install for moznetwork 17:04:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Running setup.py install for mozprocess 17:04:17 INFO - Running setup.py install for mozprofile 17:04:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Running setup.py install for mozrunner 17:04:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Running setup.py install for mozscreenshot 17:04:17 INFO - Running setup.py install for moztest 17:04:17 INFO - Running setup.py install for mozversion 17:04:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:17 INFO - Cleaning up... 17:04:17 INFO - Return code: 0 17:04:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:17 INFO - Using env: {'DISPLAY': ':0', 17:04:17 INFO - 'HOME': '/home/cltbld', 17:04:17 INFO - 'LANG': 'en_US.UTF-8', 17:04:17 INFO - 'LANGUAGE': 'en_US:en', 17:04:17 INFO - 'LOGNAME': 'cltbld', 17:04:17 INFO - 'MAIL': '/var/mail/cltbld', 17:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:17 INFO - 'MOZ_NO_REMOTE': '1', 17:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:17 INFO - 'NO_EM_RESTART': '1', 17:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:17 INFO - 'PWD': '/builds/slave/test', 17:04:17 INFO - 'SHELL': '/bin/bash', 17:04:17 INFO - 'SHLVL': '1', 17:04:17 INFO - 'TERM': 'linux', 17:04:17 INFO - 'TMOUT': '86400', 17:04:17 INFO - 'USER': 'cltbld', 17:04:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:17 INFO - '_': '/tools/buildbot/bin/python'} 17:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:18 INFO - Running setup.py (path:/tmp/pip-P1Vt8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:18 INFO - Running setup.py (path:/tmp/pip-4nwhwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:18 INFO - Running setup.py (path:/tmp/pip-g8hzto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:18 INFO - Running setup.py (path:/tmp/pip-Oo_sp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:18 INFO - Running setup.py (path:/tmp/pip-lMn3sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:18 INFO - Running setup.py (path:/tmp/pip-1rguYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:18 INFO - Running setup.py (path:/tmp/pip-RKWoKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:18 INFO - Running setup.py (path:/tmp/pip-1OIpwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:18 INFO - Running setup.py (path:/tmp/pip-AUy6cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:18 INFO - Running setup.py (path:/tmp/pip-SK24GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:18 INFO - Running setup.py (path:/tmp/pip-9qFFRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:04:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:18 INFO - Running setup.py (path:/tmp/pip-2mxaFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:19 INFO - Running setup.py (path:/tmp/pip-CZxSAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:19 INFO - Running setup.py (path:/tmp/pip-h_ULxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:19 INFO - Running setup.py (path:/tmp/pip-YR13D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:19 INFO - Running setup.py (path:/tmp/pip-CfP2zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:19 INFO - Running setup.py (path:/tmp/pip-ANAefJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:21 INFO - Downloading blessings-1.6.tar.gz 17:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:21 INFO - Installing collected packages: blessings 17:04:21 INFO - Running setup.py install for blessings 17:04:21 INFO - Successfully installed blessings 17:04:21 INFO - Cleaning up... 17:04:21 INFO - Return code: 0 17:04:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:21 INFO - Reading from file tmpfile_stdout 17:04:21 INFO - Current package versions: 17:04:21 INFO - argparse == 1.2.1 17:04:21 INFO - blessings == 1.6 17:04:21 INFO - blobuploader == 1.2.4 17:04:21 INFO - docopt == 0.6.1 17:04:21 INFO - functools32 == 3.2.3-2 17:04:21 INFO - jsonschema == 2.5.1 17:04:21 INFO - manifestparser == 1.1 17:04:21 INFO - mozInstall == 1.12 17:04:21 INFO - mozcrash == 0.17 17:04:21 INFO - mozdebug == 0.1 17:04:21 INFO - mozdevice == 0.48 17:04:21 INFO - mozfile == 1.2 17:04:21 INFO - mozhttpd == 0.7 17:04:21 INFO - mozinfo == 0.9 17:04:21 INFO - mozleak == 0.1 17:04:21 INFO - mozlog == 3.2 17:04:21 INFO - moznetwork == 0.27 17:04:21 INFO - mozprocess == 0.22 17:04:21 INFO - mozprofile == 0.28 17:04:21 INFO - mozrunner == 6.11 17:04:21 INFO - mozscreenshot == 0.1 17:04:21 INFO - mozsystemmonitor == 0.3 17:04:21 INFO - moztest == 0.7 17:04:21 INFO - mozversion == 1.4 17:04:21 INFO - psutil == 3.1.1 17:04:21 INFO - requests == 1.2.3 17:04:21 INFO - wsgiref == 0.1.2 17:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:04:21 INFO - Cleaning up... 17:04:21 INFO - Return code: 0 17:04:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:04:22 INFO - Cleaning up... 17:04:22 INFO - Return code: 0 17:04:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aed66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:04:22 INFO - Using env: {'DISPLAY': ':0', 17:04:22 INFO - 'HOME': '/home/cltbld', 17:04:22 INFO - 'LANG': 'en_US.UTF-8', 17:04:22 INFO - 'LANGUAGE': 'en_US:en', 17:04:22 INFO - 'LOGNAME': 'cltbld', 17:04:22 INFO - 'MAIL': '/var/mail/cltbld', 17:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:22 INFO - 'MOZ_NO_REMOTE': '1', 17:04:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:22 INFO - 'NO_EM_RESTART': '1', 17:04:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:22 INFO - 'PWD': '/builds/slave/test', 17:04:22 INFO - 'SHELL': '/bin/bash', 17:04:22 INFO - 'SHLVL': '1', 17:04:22 INFO - 'TERM': 'linux', 17:04:22 INFO - 'TMOUT': '86400', 17:04:22 INFO - 'USER': 'cltbld', 17:04:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:22 INFO - '_': '/tools/buildbot/bin/python'} 17:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:22 INFO - Downloading/unpacking flake8 17:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:24 INFO - no previously-included directories found matching 'docs/_build' 17:04:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:25 INFO - Running setup.py install for pep8 17:04:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:25 INFO - no previously-included directories found matching 'docs/_build' 17:04:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:25 INFO - Cleaning up... 17:04:25 INFO - Return code: 0 17:04:25 INFO - Running post-action listener: _resource_record_post_action 17:04:25 INFO - Running post-action listener: _start_resource_monitoring 17:04:25 INFO - Starting resource monitoring. 17:04:25 INFO - ##### 17:04:25 INFO - ##### Finished create-virtualenv step (success) 17:04:25 INFO - ##### 17:04:25 INFO - ##### 17:04:25 INFO - ##### Running install step. 17:04:25 INFO - ##### 17:04:25 INFO - Running pre-action listener: _resource_record_pre_action 17:04:25 INFO - Running main action method: install 17:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:25 INFO - Reading from file tmpfile_stdout 17:04:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:25 INFO - Reading from file tmpfile_stdout 17:04:25 INFO - Output received: 17:04:25 INFO - Usage: mozinstall [options] installer 17:04:25 INFO - Options: 17:04:25 INFO - -h, --help show this help message and exit 17:04:25 INFO - -d DEST, --destination=DEST 17:04:25 INFO - Directory to install application into. [default: 17:04:25 INFO - "/builds/slave/test"] 17:04:25 INFO - --app=APP Application being installed. [default: firefox] 17:04:25 INFO - mkdir: /builds/slave/test/build/application 17:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:04:42 INFO - Reading from file tmpfile_stdout 17:04:42 INFO - Output received: 17:04:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:04:42 INFO - Running post-action listener: _resource_record_post_action 17:04:42 INFO - ##### 17:04:42 INFO - ##### Finished install step (success) 17:04:42 INFO - ##### 17:04:42 INFO - ##### 17:04:42 INFO - ##### Running run-tests step. 17:04:42 INFO - ##### 17:04:42 INFO - Running pre-action listener: _resource_record_pre_action 17:04:42 INFO - Running main action method: run_tests 17:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:42 INFO - Python 2.7.3 17:04:42 INFO - Return code: 0 17:04:42 INFO - grabbing minidump binary from tooltool 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 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 0x25201c0>, '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 0x25210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2521550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:04:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:04:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:04:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:42 INFO - Return code: 0 17:04:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:04:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:04:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:04:43 INFO - Return code: 0 17:04:43 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/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:04:43 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/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:04:43 INFO - Using env: {'DISPLAY': ':0', 17:04:43 INFO - 'HOME': '/home/cltbld', 17:04:43 INFO - 'LANG': 'en_US.UTF-8', 17:04:43 INFO - 'LANGUAGE': 'en_US:en', 17:04:43 INFO - 'LOGNAME': 'cltbld', 17:04:43 INFO - 'MAIL': '/var/mail/cltbld', 17:04:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:43 INFO - 'MOZ_NO_REMOTE': '1', 17:04:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:43 INFO - 'NO_EM_RESTART': '1', 17:04:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:43 INFO - 'PWD': '/builds/slave/test', 17:04:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:43 INFO - 'SHELL': '/bin/bash', 17:04:43 INFO - 'SHLVL': '1', 17:04:43 INFO - 'TERM': 'linux', 17:04:43 INFO - 'TMOUT': '86400', 17:04:43 INFO - 'USER': 'cltbld', 17:04:43 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816', 17:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:43 INFO - '_': '/tools/buildbot/bin/python'} 17:04:43 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/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:04:43 INFO - mozversion application_buildid: 20160610143003 17:04:43 INFO - mozversion application_changeset: 9545df18ca9eaa35915df14e23543c02363ff83e 17:04:43 INFO - mozversion application_display_name: Nightly 17:04:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:43 INFO - mozversion application_name: Firefox 17:04:43 INFO - mozversion application_remotingname: firefox 17:04:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:04:43 INFO - mozversion application_vendor: Mozilla 17:04:43 INFO - mozversion application_version: 50.0a1 17:04:43 INFO - mozversion platform_buildid: 20160610143003 17:04:43 INFO - mozversion platform_changeset: 9545df18ca9eaa35915df14e23543c02363ff83e 17:04:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:04:43 INFO - mozversion platform_version: 50.0a1 17:04:43 INFO - using testdate: 1465603483 17:04:43 INFO - actual date: 1465603483 17:04:43 INFO - starting webserver on 'localhost:44843' 17:04:43 INFO - SUITE-START | Running 2 tests 17:04:43 INFO - TEST-START | dromaeo_css 17:04:43 INFO - operating with platform_type : linux_ 17:04:43 INFO - Initialising browser for dromaeo_css test... 17:04:43 INFO - TEST-INFO | started process 32599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03cHXp/profile http://localhost:44843/getInfo.html) 17:04:47 INFO - PROCESS | 32599 | __metrics Screen width/height:1600/1200 17:04:47 INFO - PROCESS | 32599 | colorDepth:24 17:04:47 INFO - PROCESS | 32599 | Browser inner width/height: 1024/697 17:04:47 INFO - PROCESS | 32599 | __metrics 17:04:48 INFO - PROCESS | 32599 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:48 INFO - PROCESS | 32599 | console.error: PushService: 17:04:48 INFO - PROCESS | 32599 | stateChangeProcessEnqueue: Error transitioning state 17:04:48 INFO - PROCESS | 32599 | UnknownError 17:04:49 INFO - TEST-INFO | 32599: exit 0 17:04:49 INFO - Browser initialized. 17:04:49 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:49 INFO - TEST-INFO | started process 32682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03cHXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:01 INFO - PROCESS | 32682 | RSS: Main: 174317568 17:05:01 INFO - PROCESS | 32682 | 17:05:53 INFO - PROCESS | 32682 | 1465603553021 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:08:01 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44843/tests/dromaeo/cssquery-ext.html) 17:08:02 INFO - PROCESS | 32682 | RSS: Main: 263086080 17:08:02 INFO - PROCESS | 32682 | 17:11:04 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-ext.html (next: http://localhost:44843/tests/dromaeo/cssquery-jquery.html) 17:11:05 INFO - PROCESS | 32682 | RSS: Main: 267755520 17:11:05 INFO - PROCESS | 32682 | 17:14:07 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44843/tests/dromaeo/cssquery-mootools.html) 17:14:07 INFO - PROCESS | 32682 | RSS: Main: 268365824 17:14:07 INFO - PROCESS | 32682 | 17:17:09 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44843/tests/dromaeo/cssquery-prototype.html) 17:17:10 INFO - PROCESS | 32682 | RSS: Main: 263127040 17:17:10 INFO - PROCESS | 32682 | 17:20:13 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44843/tests/dromaeo/cssquery-yui.html) 17:20:13 INFO - PROCESS | 32682 | RSS: Main: 251445248 17:20:13 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | Cycle 1(1): loaded http://localhost:44843/tests/dromaeo/cssquery-yui.html (next: http://localhost:44843/tests/dromaeo/cssquery-dojo.html) 17:23:16 INFO - PROCESS | 32682 | RSS: Main: 296796160 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | __start_tp_report 17:23:16 INFO - PROCESS | 32682 | _x_x_mozilla_page_load 17:23:16 INFO - PROCESS | 32682 | _x_x_mozilla_page_load_details 17:23:16 INFO - PROCESS | 32682 | |i|pagename|runs| 17:23:16 INFO - PROCESS | 32682 | |0;dojo.html;3076.415481058599;3082.291073053196;3096.8761249550025;3121.016879682901;3142.6543080261167;5171.301874246976;5218.895622087556;5273.2617433559335;5339.679619222845;5366.785328586851;5219.321488206528;5265.473452654733;5275.973620131894;5305.071612467822;5318.734063296839;4739.336492890998;4780.498047704993;4821.54195351441;4831.661783675144;4947.356843610343;4850.369451971256;4882.877928051792;4897.265410188465;4916.803327866881;4936.333594964688;4726.787294571735;4784.186688263004;4801.7118972861745;4837.879053023667;4848.612111031127;4763.214069678499;4767.499412561666;4767.547083027107;4767.809287628491;4772.260299653559;4741.502142275081;4749.548792864673;4750.667453278272;4752.5485078917445;4819.879503012453;5164.04465173944;5171.715555644438;5182.974085129588;5219.451957544441;5223.6865788052455;5631.493165615073;5698.601097923147;5699.57253206007;5701.344345400291;5701.857453563653;5536.4186760390385;5579.13523403869;5605.131204663284;5656.745446454919;5721.971390143022;5340.706261155635;5357.383900851374;5364.973175134139;5366.651167674088;5371.060064488699;5835.328937172279;5844.444777746107;5844.59087863854;5844.9415505845245;5848.239728835224;5366.382865970385;5483.204935284361;5531.723413829292;5534.08687566547;5630.014747419185;5636;5650.886982260332;5698.4871361576825;5706.9714651426475;5710.7430165642645;5441.5102640762525;5629;5635.295588051494;5639.125935480007;5640.605157639008;5536.280283563111;5603.2435621191435;5626.493615574618;5714.171445140431;5716.42835716425;4356.564343565618;4358.825646974085;4361.01877077655;4363.38912552243;4399.406080179199;3900.3369427197445;3923.1761330120994;3925.862594809168;3958.6437220650278;3978.8209530571194;5201.895962080737;5258.763355649005;5318.149096144675;5318.97340513295;5353.304070470892;5704.543636509069;5709.314882214161;5713.657180569179;5719.48524632785;5765.971170144207;5380.24676545284;5386.138217885198;5388.811391601275;5389.353277606634;5393.352797664227;4812.5668689818085;4879.951200488021;4898.167311557044;4905.043516514317;4950.950490495121;5842.761705994612;5882.058870580772;5905.291365036137;5906.3207731110615;5908.645481271137;5467.781288748405;5671.17767923657;5683;5687.459691329317;5690.2887139107615;5853.356130825691;5891.204687367151;5901.380355062656;5919.082542205965;5924.7037648118285;5543.1962365455975;5546.140348246028;5548.195511650869;5550.75021624036;5553.250311207935;5627.240322556402;5627.662340259598;5633.492985631313;5633.915491267716;5637.915431268452;5357.624966252325;5402.9459705404015;5471.069918113851;5480.780768769364;5516.9448305516435;5500.477454641803;5500.972495137498;5501.284832971688;5503.449655034465;5506.724663766876;5224.764885580082;5363.222332761806;5367.946320536745;5375.5162035417;5430.484104010113;5493.313335833021;5542.889142217214;5553.750081246273;5627.409122042127;5653.1802888580105;5457.972710136424;5459.781608735606;5467.17992301158;5469.753861076181;5470.015397228537 17:23:16 INFO - PROCESS | 32682 | |1;ext.html;611.2359550561797;625.4464798653194;629.6977450823603;638.7732355013973;639.2967735490957;30188;33299.833500832494;33325.333493330116;33353;33387.833060834724;33873.153171170736;43407.3488897666;44441.55558444415;44617;48256.51743482564;8963.641454341818;9073.36486445949;9076.682316118937;9085.364024518254;9090.363674542752;8920.152585504367;9002.774930626754;9006.864897026517;9016.36885418021;9021.233195178418;9092.22716069135;9112.45325280482;9119.407238529508;9124.726258212231;9127;8960.23837973773;8997.640094396216;9009.774755631097;9055.185033346965;9058.27533797298;8665.566721663954;8731.083236260165;8734.47593144407;8735.606897689555;8736.563171841382;42896.78551607222;43116.137677246596;43136.56863431357;43153.784231078644;43192;3499.8775042873376;3596.2627661329625;3644.398674218751;4114.794260286973;4234.026173979971;32459.675403246136;32761.508577371358;32886.486162394;33163.83418082918;34400.31199376023;4263.360495925605;4322.351647252905;4349.739015659039;4372.409724687158;4379.912401751979;353118;353944.99999999744;354929;356051;358059;52954.20568691473;57673.711631441576;57682.423175767704;58353.416465835646;58444.415555844746;58032.70983645055;64032.35967640264;64070.67964660147;64190;64216.82590631594;15208.771868421982;15390.230488475532;15418;15428.691426171637;15450.304736286895;10418.68743937683;11469.598564050219;11626.128040396836;11637.47631356591;11647.242929209575;16720.080395578116;17051.403200887908;17347.132643367782;17569;17634.91182544079;6343.302236753953;6481.624903190422;6500.739970401226;6596.142501474777;6780.660966951633;1003.4882210072915;1032.5611615063717;1062.3201151263197;1069.6577095329576;1142.440204299887;33076.17309567232;33112.50331245033;33293.83353083268;33359.49960750591;33877.66122338794;1114.8662160540787;1123.3989815448697;1129.6893354327626;1136.9147313951487;1260.7478504299177;17117.657646846994;17400.39098631567;17413.738793918103;17540.298388064333;17569.385071522436;535544;536310;537160;537770;541071;58607.70696146492;59898.40101598928;60133;60148.39851601516;60223.698881506185;1242.7576622558695;1330.5609148980814;1348.4606157537064;1373.230990645242;1381.896357773171;31965.360692785547;34222;34618.48072278968;34707.47938780971;35185.296294073465;51352.229716555026;51591;51942.48057519377;52030.73984630052;52082.479175207765;410753;412499;413388;414518;415663;35604.64395356013;40756.388654170805;41614.58385416107;42010.579894200666;44469;48346;49047.754761225966;49450;49659.503404966934;50119.24821127759;40867.59132408757;41944.580554194064;42204;42529.14941701211;43392.13215735604;40694;41218.58781412148;41531.58468415398;41537.792311038254;41980;42304.365434517895;44407.55592444034;44848;45425.772871135436;45484.77257613823;39642.80178599089;43995;46106.308405373275;46413.30380044234;47350;34485;35584.82207588945;35925;36075.45886811752;36328.63671363253 17:23:16 INFO - PROCESS | 32682 | |2;jquery.html;377.54505820486315;391.82172111689175;392.9882103536894;393.3333000564045;409.66612211047993;17367.218475168615;19243.326483573077;20576.176952921865;20600.072996715146;20610.484737881543;18026.5493362666;18171;18188.81811181891;18207.726884096715;18510.537236569093;5638.126090455976;5839.649621022731;5861.70691465425;5909.4090590941;5924.140999555062;5700.9714951425185;5823.767049318022;5838.766449342022;5857.092150716646;5920.082387229986;5642.4357564243455;5654.321481422235;5660.981023415804;5784.1034639630925;5786.045302525078;5657.490825825675;5686.346070201917;5781.277340332437;5794.333651630074;5802;5132.101882170605;5165.380154381461;5182.507661772163;5242.082635538765;5243.187305967581;20307;21405.14379424821;21443;22448.32655020352;22682.54634907309;2283.1209984156053;2288.290629904735;2308.5267520158327;2487.6890388701413;2984.925376865574;10139.695809125664;10148.492575371201;10244.590216391336;10392.896071039268;10696.090832279266;1905.1426857913993;1972.9013549322476;1987.6720341143694;2012.275580790914;2038.3375402993938;68905.3109468909;81105.18894811094;81236.59381703053;85440.14559854384;86462.56768716179;9006.864897026418;9488.667896623585;9650.469224192597;9866.506674666238;10016.599336026624;13038.804417933548;13143.60569182926;13210.801837972438;13249.072564920556;13615.863841361657;7290.161631412349;7608.087029556378;7726.497777644435;7764.184760600168;7819.061712594411;6954.130733658293;7015.36861682451;7102.4318054555515;7108.147022357351;7134.215236324;4676.69601475903;4749.881252968704;4764.237721964539;4807.086653535817;4810.470848206694;1940.738000369932;1943.1838627776367;1945.0612509667753;1972.7139564763315;1984.6725290327222;909.8862642169729;917.6650522559218;981.2444417798256;1012.3520946594185;1033.1579762493543;18708.532286692942;19135.80864191368;19180.20494876281;19473.51316217106;19656.410307690792;964.6479035152119;982.8820541535061;986.479544763137;991.9752006199902;1024.6106479537727;9766.267529935141;10796.622118225981;10983.231173817916;10984.286021408583;11613.6515904523;476755;492079;492530;518068;519227;64954.051378458724;93335;101815.49092254491;102434.48782756038;103815;1002.1431675917132;1015.2334987084852;1039.5010395010588;1040.9271351005357;1040.9375437473625;17649.558761030563;17940.282388704305;18254.634907302046;18313.450596482126;18460.219940106632;40902.1819563613;41672.37491437692;42285.36571951485;42400.5759942409;42674.64255321237;58489.4151058484;60206.698966506636;60315.39684603098;60623.393766061774;60634.69682651559;8531.189536993976;8558.101399353227;8627.87058194115;8647.870281945901;8727.083656216006;12417.31704756247;13220.603381898558;13358.732825343634;13384.799228011392;13603.591892243248;11933.582324618945;12101.636950891487;12252.326122063372;12355.69110772238;12356.320402377956;11888;11903.702407439883;11936;12025;12029.338386388832;12287.017038637066;12412.255264684149;12422.937885310515;12439.626811195678;12595.433205505591;8378.120297368932;8793.736187914374;9003.459792412476;9055;9074.274058075207;11844.822327665264;12291.262524248574;12303;12306.138570299992;12380.257184568954 17:23:16 INFO - PROCESS | 32682 | |3;mootools.html;1300.9284489353095;1441.0777102654304;1472.1093738288334;1555.1602134847183;1731.2036463226916;7976.521408715481;8288.378371622122;8309.709160179387;8509.276711479532;8524.531150786705;8212.466189697665;8393.286570641503;8394.748157555283;8399.580020998956;8416.537090460022;2284.18911286493;2312.236961802601;2315.6294992801154;2317.1079134533243;2318.5131122464304;2312.0520586559514;2323.53529294141;2366.810655147584;2374.631932050535;2377.643353496972;2256.650219216024;2263.366257447917;2279.9772002280015;2283.931482055541;2300.022490441564;2260.604394231011;2275.169563109453;2284.6116160252714;2286.9885650571805;2287.5310561334886;2182.8253739700945;2205.2943058221376;2211.9225827095975;2213.701150344699;2214.5903007943584;8138.430309878311;8345.332373410112;8389.370797190235;8396.07643159258;8396.832063358699;4775.5701986821;4948.925766113512;4953.702777833306;4960.925586116211;4963.205887058053;3136.231623252295;3282.6224984126893;3301.1417031571723;3356.8825091121694;3382.7632065755406;1090.7218659241842;1160.2864238493266;1186.5669030803695;1226.0865655086927;1230.0405683566744;11523.078153747763;11701.53193872244;11726;11728.472218750092;11774.646760597196;4367.301231802896;4502.099580083931;4569.611583015414;4604.263317869125;4609.124266389375;9978.950105249427;9991.050850169368;10026;10040.347377420445;10045.497725113715;5007.974960125249;5012.1980483122525;5015.122353588107;5020.573251273682;5021.14640511114;3919.451276821247;3953.5453422856162;4035.29382358092;4503.504614492404;4536.319552067216;3806.904827379338;3828.48315477407;3894.3768996960353;3923.725339226227;3946.1910308387287;1249.6875781054737;1250.761137563769;1255.466426768638;1259.5528587351541;1265.9430325635185;825.7605294464659;855.7304449098514;918.5177781664546;942.7878727286443;944.7024187380953;5591.832245032656;5689.260396148474;5713.971430142823;5758.052315165068;5809.2738407699035;434.8369361489441;442.50439507750883;448.8473918867601;450.34474839109015;453.34718006071154;4031.5968403160036;4170.103427763045;4181.540030596632;4181.560936101726;4234.830606775695;10195.949020254851;10234.334768240189;10540.051395374454;10540.894591053991;10565.63020294286;10300.587976480856;10376.962303769562;10434.843477347846;10442.269041167045;10458.581656733646;7777.261160189773;7851.097123830718;7949.125596184415;8004.399670024655;8011.158828322942;5451.64564303319;5617.662940223599;5672.744726487401;5683.261176047087;5704.1443783432815;9243.121903419164;9566.856497152408;9594.04059594035;9680.225581953568;9796.559154838193;9467.857982130135;9885.604575816888;9892.109710126124;10047.497625118569;10087.69736907894;6892.207396149306;6972.09362782835;7132.037174981519;7447.404207663482;7577.052868391451;7992.560409177551;7995.760127196193;8075.919240807517;8090.797730056795;8098.392620553364;7172.856542869218;7309.5248808827255;7316.048913641405;7493.550386976799;7500.587467689329;7078.858422831618;7096.680649370687;7147.3210045045635;7261.056062711814;7327.63361831917;6615.338466153346;6681.5656982296;6682.69927853238;6727.966360168168;6741.393274605309;4904.215325547895;5068.898622027613;5113.64204505681;5129.640925135204;5142.665726727751;4986.8753281168265;5027.84916452507;5042.369703787027;5113.51421614946;5164.509371609691 17:23:16 INFO - PROCESS | 32682 | |4;prototype.html;318.8087147711374;330.1564502695613;331.99336013279736;335.414701346151;336.5826375294635;5101.209312556551;5139.229115632657;5243.790248390064;5266.605004624654;5270.209468579715;5200.271961925334;5228.372595288562;5244.449332820056;5245.86885327867;5257.211418287249;4129.504459464868;4138.358554424069;4153.252414565377;4157.625813676768;4167.916641667165;3932.233214523169;3942.4283478895545;4118.938215926763;4149.917001659965;4165.104502531955;4093.8771836844944;4113.856015039474;4126.988887722498;4129.256733787917;4141.399497072923;4094.1197642507004;4095.1604920991126;4108.726294848577;4115.218108559364;4126.607972242662;3510.297940411928;3653.3058718843336;3668.4313931340685;3674.1365779041903;3675.7059435245383;5071.923921141186;5078.695278283315;5084.51697088776;5093.9812037592255;5102.081625307444;4690.179218636759;4714.787834547454;4744.217204161309;4776.23580227162;4783.4977327380475;5270.604704647167;5430.266913966603;5436.537894278991;5462.371827239878;5488.341399032101;4057.3102572562734;4060.822361515157;4070.0463777386726;4072.124493233939;4073.490813648294;5677.858053548653;5704.515116215127;5713.657180569179;5743.913841292384;5754.510866576388;3934.409838524187;4146.523149837807;4166.395872598457;4175.519815221289;4180.916381672349;4188.790560471964;4199.454070970754;4216.430781844411;4230.471191101113;4233.1322078973735;4729.864832440189;4733.14803335396;4733.148033354029;4740.525947405301;4769.165396055676;5247.291615631917;5509.3664228614225;5510.256115424447;5520.944790552124;5546.389897111315;1389;1422.6087825847974;1433.6953372431037;1442.451868290043;1447.3848614339074;936.9109934556207;940.2571968145226;958.501579178837;961.7209111881182;969.9030096990244;4519.41247637805;4621;4633.351330813689;4652.744099074584;4681.204195286809;4887.828925987574;4895.339129217581;4908.509149085135;4927.472483530117;4936.951165266446;4570.360149579062;4619.745913974763;4693.718376897397;4753.191957367256;4765.189917713997;2655.2830735701637;2686.771624411908;2693.9326516836845;2698.2984424049887;2707.76983956362;5067.746612669352;5091.956148989522;5108.310378098983;5111.846644600668;5116.692998420107;4700;5016.724080175552;5041.747912604355;5048.29323894655;5061.621038112082;5079.2381142828135;5113.002964421902;5128.538431541179;5129.076766182123;5135.6405051646025;4929.69363118781;4950.836553409874;4960;4966.6771659842;4969.975150124226;4909.533594308535;4917.549322949667;4945.357103576512;5195.272661827272;5616.7191640416995;5849.824505264849;5860.355360910211;5865.618734782225;5876;5887.793927212527;4062.5531191569494;4074.0851799654115;4084.8366065357054;4086.8773936781945;4094.2630326541507;5341.97329013368;5372.006178856924;5524.1989911463415;5723.454667239738;5737.282839645044;5497.47773961473;5499.7250137492165;5515.531179849758;5515.751791169327;5523.558115350843;5509;5520.392756796829;5521;5546.195801608664;5561.499465048003;5212.765425555935;5364.517193452608;5397.920415916754;5408.8377348679605;5423.888102938967;5509.696966666712;5539.695316757617;5553.500184983371;5557.777688892399;5574.996500629925;5313.661988724949;5375.220593014069;5401.729913504388;5420.457954204548;5460.535854452257 17:23:16 INFO - PROCESS | 32682 | |5;yui.html;752.2139364364239;773.8955241042459;784.3372350363941;798.1260519730893;828.9751307460779;14245.216513091777;15444.61388465289;15654.295556699948;15760.921195394007;15852;14610.123392596452;15111.395544178247;15225.695486090272;15839.445619403323;15853.20733963303;658.4600627485464;777.6306254529081;801.1627848897915;803.1968031968032;809.6558962440969;797.8484088023285;806.1253539909205;806.31060443321;808.737160422862;809.0776514773163;846.6147902704286;847.4406891451644;848.9108643592426;851.0383266908385;851.1190917400492;691.882379995402;825.6202147012382;840.8024114333127;844.543946269014;844.9746507604751;621.7761605821901;621.9502439804804;622.4366947912147;622.7384498510636;623.0560700538642;14247.358868850926;14284.214368209745;14356.569302920929;14373.137611743328;14411.639709007253;13775.517856874962;14213.289335533182;14221.857781422157;14341.21123338216;14404.351804168837;12085.733075589456;12148.514059437612;12259.816102758467;12344.259344439362;12404.25574465526;4373.365861950031;4433.290673492225;4468.262736648449;4539.795709193094;4661.766911654404;68177;68888;69791.65104174498;71346.64326678385;71381.64309178421;10705.892941070646;10790.89209107899;10850.348979061124;10865.293755906;11313.094952403788;21323;21340.359789206348;21346.466338341666;21388.251411200534;21428.89285553562;8507.489550626982;8525.360597955178;8583.141685831491;8669.783255418539;8758.080401557745;4576.382188404589;4643.95356046442;4677.18149323867;4722.95277047232;4771.73755443447;3553.3071051145293;3624.1120925373452;3647.6534729200685;3672.1003354178397;3677.889663310105;553.3221803291017;563.7463141586303;568.5536853569928;582.912563115536;587.0577722754916;615.4676205082571;668.1280928388403;671.4863129705778;673.5016088094775;696.502001069238;9346.57940392684;9835.529736877192;9854;9862.42201247797;9997.300188986846;579.3241880269682;604.8094850122197;662.8276648071536;678.1827897383641;679.5277282288762;4523.424878836839;4636.4436267647425;4659.440867095903;4766.331783875685;4865.6107511399005;69832;99240;103280.48359758154;105426.47286763517;107148.4642576782;69444.30555694379;96793.51603241939;96920.51539742257;99330.5033474828;101017;53048.73475632597;78014.60992695113;83015;83369.16630833736;83442;8980.685676001309;9149.013065067837;9169.954150229207;9235.12266334697;9288.72133835986;51023.74488127536;52239.21641175461;52427.21359179691;52495.73752131215;52997.205041925175;68773.65613171902;69700;73016.26983730095;74582.62708686422;75518;11529.308241505536;11592.88407115918;11675.532978680758;11877.46551405206;11887;12612.747745044864;12632.2420654761;12869.678258043623;12887.097903147065;13027.934860325639;12033.578824741093;12069.10238345672;12585.559505417266;12688.746225075261;12769.61691149267;11969.820452693042;12023.879761202275;12127.222778708607;12235.93882030584;12527.31099789484;11468.254563453349;11625.825612615648;11995.880041199476;12269.69325766863;12283.447244874182;9609;9819.705408837746;10069.597216111273;10214.591416343561;10250.38497690141;10093.343932644355;10308.208240178725;10466;10541.78916421652;10570.682879513626 17:23:16 INFO - PROCESS | 32682 | __end_tp_report 17:23:16 INFO - PROCESS | 32682 | __start_cc_report 17:23:16 INFO - PROCESS | 32682 | _x_x_mozilla_cycle_collect,738 17:23:16 INFO - PROCESS | 32682 | __end_cc_report 17:23:16 INFO - PROCESS | 32682 | __startTimestamp1465604596642__endTimestamp 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | ------- Summary: start ------- 17:23:16 INFO - PROCESS | 32682 | Number of tests: 6 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#0] dojo.html Cycles:165 Average:5253.84 Median:5430.48 stddev:585.04 (10.8%) stddev-sans-first:561.34 17:23:16 INFO - PROCESS | 32682 | Values: 3076.4 3082.3 3096.9 3121.0 3142.7 5171.3 5218.9 5273.3 5339.7 5366.8 5219.3 5265.5 5276.0 5305.1 5318.7 4739.3 4780.5 4821.5 4831.7 4947.4 4850.4 4882.9 4897.3 4916.8 4936.3 4726.8 4784.2 4801.7 4837.9 4848.6 4763.2 4767.5 4767.5 4767.8 4772.3 4741.5 4749.5 4750.7 4752.5 4819.9 5164.0 5171.7 5183.0 5219.5 5223.7 5631.5 5698.6 5699.6 5701.3 5701.9 5536.4 5579.1 5605.1 5656.7 5722.0 5340.7 5357.4 5365.0 5366.7 5371.1 5835.3 5844.4 5844.6 5844.9 5848.2 5366.4 5483.2 5531.7 5534.1 5630.0 5636.0 5650.9 5698.5 5707.0 5710.7 5441.5 5629.0 5635.3 5639.1 5640.6 5536.3 5603.2 5626.5 5714.2 5716.4 4356.6 4358.8 4361.0 4363.4 4399.4 3900.3 3923.2 3925.9 3958.6 3978.8 5201.9 5258.8 5318.1 5319.0 5353.3 5704.5 5709.3 5713.7 5719.5 5766.0 5380.2 5386.1 5388.8 5389.4 5393.4 4812.6 4880.0 4898.2 4905.0 4951.0 5842.8 5882.1 5905.3 5906.3 5908.6 5467.8 5671.2 5683.0 5687.5 5690.3 5853.4 5891.2 5901.4 5919.1 5924.7 5543.2 5546.1 5548.2 5550.8 5553.3 5627.2 5627.7 5633.5 5633.9 5637.9 5357.6 5402.9 5471.1 5480.8 5516.9 5500.5 5501.0 5501.3 5503.4 5506.7 5224.8 5363.2 5367.9 5375.5 5430.5 5493.3 5542.9 5553.8 5627.4 5653.2 5458.0 5459.8 5467.2 5469.8 5470.0 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#1] ext.html Cycles:180 Average:60580.45 Median:23396.25 stddev:116979.42 (500.0%) stddev-sans-first:117220.93 17:23:16 INFO - PROCESS | 32682 | Values: 611.2 625.4 629.7 638.8 639.3 30188.0 33299.8 33325.3 33353.0 33387.8 33873.2 43407.3 44441.6 44617.0 48256.5 8963.6 9073.4 9076.7 9085.4 9090.4 8920.2 9002.8 9006.9 9016.4 9021.2 9092.2 9112.5 9119.4 9124.7 9127.0 8960.2 8997.6 9009.8 9055.2 9058.3 8665.6 8731.1 8734.5 8735.6 8736.6 42896.8 43116.1 43136.6 43153.8 43192.0 3499.9 3596.3 3644.4 4114.8 4234.0 32459.7 32761.5 32886.5 33163.8 34400.3 4263.4 4322.4 4349.7 4372.4 4379.9 353118.0 353945.0 354929.0 356051.0 358059.0 52954.2 57673.7 57682.4 58353.4 58444.4 58032.7 64032.4 64070.7 64190.0 64216.8 15208.8 15390.2 15418.0 15428.7 15450.3 10418.7 11469.6 11626.1 11637.5 11647.2 16720.1 17051.4 17347.1 17569.0 17634.9 6343.3 6481.6 6500.7 6596.1 6780.7 1003.5 1032.6 1062.3 1069.7 1142.4 33076.2 33112.5 33293.8 33359.5 33877.7 1114.9 1123.4 1129.7 1136.9 1260.7 17117.7 17400.4 17413.7 17540.3 17569.4 535544.0 536310.0 537160.0 537770.0 541071.0 58607.7 59898.4 60133.0 60148.4 60223.7 1242.8 1330.6 1348.5 1373.2 1381.9 31965.4 34222.0 34618.5 34707.5 35185.3 51352.2 51591.0 51942.5 52030.7 52082.5 410753.0 412499.0 413388.0 414518.0 415663.0 35604.6 40756.4 41614.6 42010.6 44469.0 48346.0 49047.8 49450.0 49659.5 50119.2 40867.6 41944.6 42204.0 42529.1 43392.1 40694.0 41218.6 41531.6 41537.8 41980.0 42304.4 44407.6 44848.0 45425.8 45484.8 39642.8 43995.0 46106.3 46413.3 47350.0 34485.0 35584.8 35925.0 36075.5 36328.6 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#2] jquery.html Cycles:180 Average:29268.06 Median:1681.24 stddev:82489.50 (4906.5%) stddev-sans-first:82692.38 17:23:16 INFO - PROCESS | 32682 | Values: 377.5 391.8 393.0 393.3 409.7 17367.2 19243.3 20576.2 20600.1 20610.5 18026.5 18171.0 18188.8 18207.7 18510.5 5638.1 5839.6 5861.7 5909.4 5924.1 5701.0 5823.8 5838.8 5857.1 5920.1 5642.4 5654.3 5661.0 5784.1 5786.0 5657.5 5686.3 5781.3 5794.3 5802.0 5132.1 5165.4 5182.5 5242.1 5243.2 20307.0 21405.1 21443.0 22448.3 22682.5 2283.1 2288.3 2308.5 2487.7 2984.9 10139.7 10148.5 10244.6 10392.9 10696.1 1905.1 1972.9 1987.7 2012.3 2038.3 68905.3 81105.2 81236.6 85440.1 86462.6 9006.9 9488.7 9650.5 9866.5 10016.6 13038.8 13143.6 13210.8 13249.1 13615.9 7290.2 7608.1 7726.5 7764.2 7819.1 6954.1 7015.4 7102.4 7108.1 7134.2 4676.7 4749.9 4764.2 4807.1 4810.5 1940.7 1943.2 1945.1 1972.7 1984.7 909.9 917.7 981.2 1012.4 1033.2 18708.5 19135.8 19180.2 19473.5 19656.4 964.6 982.9 986.5 992.0 1024.6 9766.3 10796.6 10983.2 10984.3 11613.7 476755.0 492079.0 492530.0 518068.0 519227.0 64954.1 93335.0 101815.5 102434.5 103815.0 1002.1 1015.2 1039.5 1040.9 1040.9 17649.6 17940.3 18254.6 18313.5 18460.2 40902.2 41672.4 42285.4 42400.6 42674.6 58489.4 60206.7 60315.4 60623.4 60634.7 8531.2 8558.1 8627.9 8647.9 8727.1 12417.3 13220.6 13358.7 13384.8 13603.6 11933.6 12101.6 12252.3 12355.7 12356.3 11888.0 11903.7 11936.0 12025.0 12029.3 12287.0 12412.3 12422.9 12439.6 12595.4 8378.1 8793.7 9003.5 9055.0 9074.3 11844.8 12291.3 12303.0 12306.1 12380.3 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#3] mootools.html Cycles:180 Average:5543.48 Median:4839.89 stddev:3145.80 (65.0%) stddev-sans-first:3138.47 17:23:16 INFO - PROCESS | 32682 | Values: 1300.9 1441.1 1472.1 1555.2 1731.2 7976.5 8288.4 8309.7 8509.3 8524.5 8212.5 8393.3 8394.7 8399.6 8416.5 2284.2 2312.2 2315.6 2317.1 2318.5 2312.1 2323.5 2366.8 2374.6 2377.6 2256.7 2263.4 2280.0 2283.9 2300.0 2260.6 2275.2 2284.6 2287.0 2287.5 2182.8 2205.3 2211.9 2213.7 2214.6 8138.4 8345.3 8389.4 8396.1 8396.8 4775.6 4948.9 4953.7 4960.9 4963.2 3136.2 3282.6 3301.1 3356.9 3382.8 1090.7 1160.3 1186.6 1226.1 1230.0 11523.1 11701.5 11726.0 11728.5 11774.6 4367.3 4502.1 4569.6 4604.3 4609.1 9979.0 9991.1 10026.0 10040.3 10045.5 5008.0 5012.2 5015.1 5020.6 5021.1 3919.5 3953.5 4035.3 4503.5 4536.3 3806.9 3828.5 3894.4 3923.7 3946.2 1249.7 1250.8 1255.5 1259.6 1265.9 825.8 855.7 918.5 942.8 944.7 5591.8 5689.3 5714.0 5758.1 5809.3 434.8 442.5 448.8 450.3 453.3 4031.6 4170.1 4181.5 4181.6 4234.8 10195.9 10234.3 10540.1 10540.9 10565.6 10300.6 10377.0 10434.8 10442.3 10458.6 7777.3 7851.1 7949.1 8004.4 8011.2 5451.6 5617.7 5672.7 5683.3 5704.1 9243.1 9566.9 9594.0 9680.2 9796.6 9467.9 9885.6 9892.1 10047.5 10087.7 6892.2 6972.1 7132.0 7447.4 7577.1 7992.6 7995.8 8075.9 8090.8 8098.4 7172.9 7309.5 7316.0 7493.6 7500.6 7078.9 7096.7 7147.3 7261.1 7327.6 6615.3 6681.6 6682.7 6728.0 6741.4 4904.2 5068.9 5113.6 5129.6 5142.7 4986.9 5027.8 5042.4 5113.5 5164.5 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#4] prototype.html Cycles:180 Average:4494.39 Median:4955.42 stddev:1284.08 (25.9%) stddev-sans-first:1248.85 17:23:16 INFO - PROCESS | 32682 | Values: 318.8 330.2 332.0 335.4 336.6 5101.2 5139.2 5243.8 5266.6 5270.2 5200.3 5228.4 5244.4 5245.9 5257.2 4129.5 4138.4 4153.3 4157.6 4167.9 3932.2 3942.4 4118.9 4149.9 4165.1 4093.9 4113.9 4127.0 4129.3 4141.4 4094.1 4095.2 4108.7 4115.2 4126.6 3510.3 3653.3 3668.4 3674.1 3675.7 5071.9 5078.7 5084.5 5094.0 5102.1 4690.2 4714.8 4744.2 4776.2 4783.5 5270.6 5430.3 5436.5 5462.4 5488.3 4057.3 4060.8 4070.0 4072.1 4073.5 5677.9 5704.5 5713.7 5743.9 5754.5 3934.4 4146.5 4166.4 4175.5 4180.9 4188.8 4199.5 4216.4 4230.5 4233.1 4729.9 4733.1 4733.1 4740.5 4769.2 5247.3 5509.4 5510.3 5520.9 5546.4 1389.0 1422.6 1433.7 1442.5 1447.4 936.9 940.3 958.5 961.7 969.9 4519.4 4621.0 4633.4 4652.7 4681.2 4887.8 4895.3 4908.5 4927.5 4937.0 4570.4 4619.7 4693.7 4753.2 4765.2 2655.3 2686.8 2693.9 2698.3 2707.8 5067.7 5092.0 5108.3 5111.8 5116.7 4700.0 5016.7 5041.7 5048.3 5061.6 5079.2 5113.0 5128.5 5129.1 5135.6 4929.7 4950.8 4960.0 4966.7 4970.0 4909.5 4917.5 4945.4 5195.3 5616.7 5849.8 5860.4 5865.6 5876.0 5887.8 4062.6 4074.1 4084.8 4086.9 4094.3 5342.0 5372.0 5524.2 5723.5 5737.3 5497.5 5499.7 5515.5 5515.8 5523.6 5509.0 5520.4 5521.0 5546.2 5561.5 5212.8 5364.5 5397.9 5408.8 5423.9 5509.7 5539.7 5553.5 5557.8 5575.0 5313.7 5375.2 5401.7 5420.5 5460.5 17:23:16 INFO - PROCESS | 32682 | 17:23:16 INFO - PROCESS | 32682 | [#5] yui.html Cycles:180 Average:19364.31 Median:4818.67 stddev:27218.32 (564.9%) stddev-sans-first:27258.80 17:23:16 INFO - PROCESS | 32682 | Values: 752.2 773.9 784.3 798.1 829.0 14245.2 15444.6 15654.3 15760.9 15852.0 14610.1 15111.4 15225.7 15839.4 15853.2 658.5 777.6 801.2 803.2 809.7 797.8 806.1 806.3 808.7 809.1 846.6 847.4 848.9 851.0 851.1 691.9 825.6 840.8 844.5 845.0 621.8 622.0 622.4 622.7 623.1 14247.4 14284.2 14356.6 14373.1 14411.6 13775.5 14213.3 14221.9 14341.2 14404.4 12085.7 12148.5 12259.8 12344.3 12404.3 4373.4 4433.3 4468.3 4539.8 4661.8 68177.0 68888.0 69791.7 71346.6 71381.6 10705.9 10790.9 10850.3 10865.3 11313.1 21323.0 21340.4 21346.5 21388.3 21428.9 8507.5 8525.4 8583.1 8669.8 8758.1 4576.4 4644.0 4677.2 4723.0 4771.7 3553.3 3624.1 3647.7 3672.1 3677.9 553.3 563.7 568.6 582.9 587.1 615.5 668.1 671.5 673.5 696.5 9346.6 9835.5 9854.0 9862.4 9997.3 579.3 604.8 662.8 678.2 679.5 4523.4 4636.4 4659.4 4766.3 4865.6 69832.0 99240.0 103280.5 105426.5 107148.5 69444.3 96793.5 96920.5 99330.5 101017.0 53048.7 78014.6 83015.0 83369.2 83442.0 8980.7 9149.0 9170.0 9235.1 9288.7 51023.7 52239.2 52427.2 52495.7 52997.2 68773.7 69700.0 73016.3 74582.6 75518.0 11529.3 11592.9 11675.5 11877.5 11887.0 12612.7 12632.2 12869.7 12887.1 13027.9 12033.6 12069.1 12585.6 12688.7 12769.6 11969.8 12023.9 12127.2 12235.9 12527.3 11468.3 11625.8 11995.9 12269.7 12283.4 9609.0 9819.7 10069.6 10214.6 10250.4 10093.3 10308.2 10466.0 10541.8 10570.7 17:23:16 INFO - PROCESS | 32682 | -------- Summary: end -------- 17:23:16 INFO - PROCESS | 32682 | 17:23:17 INFO - TEST-INFO | 32682: exit 0 17:23:17 INFO - TEST-OK | dromaeo_css | took 1113795ms 17:23:17 INFO - TEST-START | kraken 17:23:17 INFO - operating with platform_type : linux_ 17:23:17 INFO - Initialising browser for kraken test... 17:23:17 INFO - TEST-INFO | started process 399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8mgOb/profile http://localhost:44843/getInfo.html) 17:23:21 INFO - PROCESS | 399 | __metrics Screen width/height:1600/1200 17:23:21 INFO - PROCESS | 399 | colorDepth:24 17:23:21 INFO - PROCESS | 399 | Browser inner width/height: 1024/697 17:23:21 INFO - PROCESS | 399 | __metrics 17:23:22 INFO - PROCESS | 399 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:22 INFO - PROCESS | 399 | console.error: PushService: 17:23:22 INFO - PROCESS | 399 | stateChangeProcessEnqueue: Error transitioning state 17:23:22 INFO - PROCESS | 399 | UnknownError 17:23:23 INFO - TEST-INFO | 399: exit 0 17:23:23 INFO - Browser initialized. 17:23:23 INFO - Running cycle 1/1 for kraken test... 17:23:23 INFO - TEST-INFO | started process 481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB8mgOb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:35 INFO - PROCESS | 481 | RSS: Main: 173645824 17:23:35 INFO - PROCESS | 481 | 17:23:37 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44843/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:38 INFO - PROCESS | 481 | RSS: Main: 232988672 17:23:38 INFO - PROCESS | 481 | 17:23:41 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44843/tests/kraken/driver.html?testName=audio-dft) 17:23:41 INFO - PROCESS | 481 | RSS: Main: 219848704 17:23:41 INFO - PROCESS | 481 | 17:23:45 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44843/tests/kraken/driver.html?testName=audio-fft) 17:23:45 INFO - PROCESS | 481 | RSS: Main: 286625792 17:23:45 INFO - PROCESS | 481 | 17:23:47 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44843/tests/kraken/driver.html?testName=audio-oscillator) 17:23:48 INFO - PROCESS | 481 | RSS: Main: 198082560 17:23:48 INFO - PROCESS | 481 | 17:23:50 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:51 INFO - PROCESS | 481 | RSS: Main: 201719808 17:23:51 INFO - PROCESS | 481 | 17:23:54 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44843/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:54 INFO - PROCESS | 481 | RSS: Main: 236331008 17:23:54 INFO - PROCESS | 481 | 17:23:58 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44843/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:58 INFO - PROCESS | 481 | RSS: Main: 238538752 17:23:58 INFO - PROCESS | 481 | 17:24:01 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44843/tests/kraken/driver.html?testName=json-parse-financial) 17:24:02 INFO - PROCESS | 481 | RSS: Main: 238424064 17:24:02 INFO - PROCESS | 481 | 17:24:03 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:04 INFO - PROCESS | 481 | RSS: Main: 225128448 17:24:04 INFO - PROCESS | 481 | 17:24:06 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:06 INFO - PROCESS | 481 | RSS: Main: 228655104 17:24:06 INFO - PROCESS | 481 | 17:24:08 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:09 INFO - PROCESS | 481 | RSS: Main: 237699072 17:24:09 INFO - PROCESS | 481 | 17:24:12 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:12 INFO - PROCESS | 481 | RSS: Main: 237780992 17:24:12 INFO - PROCESS | 481 | 17:24:15 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:15 INFO - PROCESS | 481 | RSS: Main: 237645824 17:24:15 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | Cycle 1(1): loaded http://localhost:44843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44843/tests/kraken/driver.html?testName=ai-astar) 17:24:17 INFO - PROCESS | 481 | RSS: Main: 280330240 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | __start_tp_report 17:24:17 INFO - PROCESS | 481 | _x_x_mozilla_page_load 17:24:17 INFO - PROCESS | 481 | _x_x_mozilla_page_load_details 17:24:17 INFO - PROCESS | 481 | |i|pagename|runs| 17:24:17 INFO - PROCESS | 481 | |0;ai-astar;109;106;109;109;110;109;110;114;109;109 17:24:17 INFO - PROCESS | 481 | |1;audio-beat-detection;155;128;130;178;129;126;150;125;165;125 17:24:17 INFO - PROCESS | 481 | |2;audio-dft;161;161;161;160;160;162;161;162;163;161 17:24:17 INFO - PROCESS | 481 | |3;audio-fft;75;74;75;156;75;77;75;76;122;73 17:24:17 INFO - PROCESS | 481 | |4;audio-oscillator;86;86;124;86;85;85;123;85;86;131 17:24:17 INFO - PROCESS | 481 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;116 17:24:17 INFO - PROCESS | 481 | |6;imaging-darkroom;145;145;145;145;147;145;145;145;145;146 17:24:17 INFO - PROCESS | 481 | |7;imaging-desaturate;95;94;94;95;95;94;94;94;95;94 17:24:17 INFO - PROCESS | 481 | |8;json-parse-financial;55;52;52;54;57;52;54;53;52;54 17:24:17 INFO - PROCESS | 481 | |9;json-stringify-tinderbox;60;60;60;61;62;60;61;60;61;61 17:24:17 INFO - PROCESS | 481 | |10;stanford-crypto-aes;80;78;78;84;86;83;80;81;121;81 17:24:17 INFO - PROCESS | 481 | |11;stanford-crypto-ccm;128;121;127;119;118;121;127;121;134;123 17:24:17 INFO - PROCESS | 481 | |12;stanford-crypto-pbkdf2;158;161;161;165;163;158;160;157;159;158 17:24:17 INFO - PROCESS | 481 | |13;stanford-crypto-sha256-iterative;67;63;64;62;67;65;63;62;62;67 17:24:17 INFO - PROCESS | 481 | __end_tp_report 17:24:17 INFO - PROCESS | 481 | __start_cc_report 17:24:17 INFO - PROCESS | 481 | _x_x_mozilla_cycle_collect,1625 17:24:17 INFO - PROCESS | 481 | __end_cc_report 17:24:17 INFO - PROCESS | 481 | __startTimestamp1465604657835__endTimestamp 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | ------- Summary: start ------- 17:24:17 INFO - PROCESS | 481 | Number of tests: 14 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.00 stddev:1.96 (1.8%) stddev-sans-first:2.07 17:24:17 INFO - PROCESS | 481 | Values: 109.0 106.0 109.0 109.0 110.0 109.0 110.0 114.0 109.0 109.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.00 stddev:19.42 (13.9%) stddev-sans-first:19.93 17:24:17 INFO - PROCESS | 481 | Values: 155.0 128.0 130.0 178.0 129.0 126.0 150.0 125.0 165.0 125.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 17:24:17 INFO - PROCESS | 481 | Values: 161.0 161.0 161.0 160.0 160.0 162.0 161.0 162.0 163.0 161.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#3] audio-fft Cycles:10 Average:87.80 Median:75.00 stddev:28.17 (37.6%) stddev-sans-first:29.49 17:24:17 INFO - PROCESS | 481 | Values: 75.0 74.0 75.0 156.0 75.0 77.0 75.0 76.0 122.0 73.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.50 stddev:19.64 (23.0%) stddev-sans-first:20.37 17:24:17 INFO - PROCESS | 481 | Values: 86.0 86.0 124.0 86.0 85.0 85.0 123.0 85.0 86.0 131.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:24:17 INFO - PROCESS | 481 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:24:17 INFO - PROCESS | 481 | Values: 145.0 145.0 145.0 145.0 147.0 145.0 145.0 145.0 145.0 146.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:24:17 INFO - PROCESS | 481 | Values: 95.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.65 (3.1%) stddev-sans-first:1.66 17:24:17 INFO - PROCESS | 481 | Values: 55.0 52.0 52.0 54.0 57.0 52.0 54.0 53.0 52.0 54.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 17:24:17 INFO - PROCESS | 481 | Values: 60.0 60.0 60.0 61.0 62.0 60.0 61.0 60.0 61.0 61.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:81.00 stddev:12.83 (15.8%) stddev-sans-first:13.47 17:24:17 INFO - PROCESS | 481 | Values: 80.0 78.0 78.0 84.0 86.0 83.0 80.0 81.0 121.0 81.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:125.00 stddev:4.98 (4.0%) stddev-sans-first:5.05 17:24:17 INFO - PROCESS | 481 | Values: 128.0 121.0 127.0 119.0 118.0 121.0 127.0 121.0 134.0 123.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.50 stddev:2.54 (1.6%) stddev-sans-first:2.59 17:24:17 INFO - PROCESS | 481 | Values: 158.0 161.0 161.0 165.0 163.0 158.0 160.0 157.0 159.0 158.0 17:24:17 INFO - PROCESS | 481 | 17:24:17 INFO - PROCESS | 481 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:2.15 (3.3%) stddev-sans-first:2.03 17:24:17 INFO - PROCESS | 481 | Values: 67.0 63.0 64.0 62.0 67.0 65.0 63.0 62.0 62.0 67.0 17:24:17 INFO - PROCESS | 481 | -------- Summary: end -------- 17:24:17 INFO - PROCESS | 481 | 17:24:18 INFO - TEST-INFO | 481: exit 0 17:24:18 INFO - TEST-OK | kraken | took 61388ms 17:24:18 INFO - SUITE-END | took 1175s 17:24:18 INFO - Completed test suite (00:19:35) 17:24:18 INFO - javascript benchmark 17:24:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.415481058599, 3082.291073053196, 3096.8761249550025, 3121.016879682901, 3142.6543080261167, 5171.301874246976, 5218.895622087556, 5273.2617433559335, 5339.679619222845, 5366.785328586851, 5219.321488206528, 5265.473452654733, 5275.973620131894, 5305.071612467822, 5318.734063296839, 4739.336492890998, 4780.498047704993, 4821.54195351441, 4831.661783675144, 4947.356843610343, 4850.369451971256, 4882.877928051792, 4897.265410188465, 4916.803327866881, 4936.333594964688, 4726.787294571735, 4784.186688263004, 4801.7118972861745, 4837.879053023667, 4848.612111031127, 4763.214069678499, 4767.499412561666, 4767.547083027107, 4767.809287628491, 4772.260299653559, 4741.502142275081, 4749.548792864673, 4750.667453278272, 4752.5485078917445, 4819.879503012453, 5164.04465173944, 5171.715555644438, 5182.974085129588, 5219.451957544441, 5223.6865788052455, 5631.493165615073, 5698.601097923147, 5699.57253206007, 5701.344345400291, 5701.857453563653, 5536.4186760390385, 5579.13523403869, 5605.131204663284, 5656.745446454919, 5721.971390143022, 5340.706261155635, 5357.383900851374, 5364.973175134139, 5366.651167674088, 5371.060064488699, 5835.328937172279, 5844.444777746107, 5844.59087863854, 5844.9415505845245, 5848.239728835224, 5366.382865970385, 5483.204935284361, 5531.723413829292, 5534.08687566547, 5630.014747419185, 5636.0, 5650.886982260332, 5698.4871361576825, 5706.9714651426475, 5710.7430165642645, 5441.5102640762525, 5629.0, 5635.295588051494, 5639.125935480007, 5640.605157639008, 5536.280283563111, 5603.2435621191435, 5626.493615574618, 5714.171445140431, 5716.42835716425, 4356.564343565618, 4358.825646974085, 4361.01877077655, 4363.38912552243, 4399.406080179199, 3900.3369427197445, 3923.1761330120994, 3925.862594809168, 3958.6437220650278, 3978.8209530571194, 5201.895962080737, 5258.763355649005, 5318.149096144675, 5318.97340513295, 5353.304070470892, 5704.543636509069, 5709.314882214161, 5713.657180569179, 5719.48524632785, 5765.971170144207, 5380.24676545284, 5386.138217885198, 5388.811391601275, 5389.353277606634, 5393.352797664227, 4812.5668689818085, 4879.951200488021, 4898.167311557044, 4905.043516514317, 4950.950490495121, 5842.761705994612, 5882.058870580772, 5905.291365036137, 5906.3207731110615, 5908.645481271137, 5467.781288748405, 5671.17767923657, 5683.0, 5687.459691329317, 5690.2887139107615, 5853.356130825691, 5891.204687367151, 5901.380355062656, 5919.082542205965, 5924.7037648118285, 5543.1962365455975, 5546.140348246028, 5548.195511650869, 5550.75021624036, 5553.250311207935, 5627.240322556402, 5627.662340259598, 5633.492985631313, 5633.915491267716, 5637.915431268452, 5357.624966252325, 5402.9459705404015, 5471.069918113851, 5480.780768769364, 5516.9448305516435, 5500.477454641803, 5500.972495137498, 5501.284832971688, 5503.449655034465, 5506.724663766876, 5224.764885580082, 5363.222332761806, 5367.946320536745, 5375.5162035417, 5430.484104010113, 5493.313335833021, 5542.889142217214, 5553.750081246273, 5627.409122042127, 5653.1802888580105, 5457.972710136424, 5459.781608735606, 5467.17992301158, 5469.753861076181, 5470.015397228537], "value": 5215.436762369745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.2359550561797, 625.4464798653194, 629.6977450823603, 638.7732355013973, 639.2967735490957, 30188.0, 33299.833500832494, 33325.333493330116, 33353.0, 33387.833060834724, 33873.153171170736, 43407.3488897666, 44441.55558444415, 44617.0, 48256.51743482564, 8963.641454341818, 9073.36486445949, 9076.682316118937, 9085.364024518254, 9090.363674542752, 8920.152585504367, 9002.774930626754, 9006.864897026517, 9016.36885418021, 9021.233195178418, 9092.22716069135, 9112.45325280482, 9119.407238529508, 9124.726258212231, 9127.0, 8960.23837973773, 8997.640094396216, 9009.774755631097, 9055.185033346965, 9058.27533797298, 8665.566721663954, 8731.083236260165, 8734.47593144407, 8735.606897689555, 8736.563171841382, 42896.78551607222, 43116.137677246596, 43136.56863431357, 43153.784231078644, 43192.0, 3499.8775042873376, 3596.2627661329625, 3644.398674218751, 4114.794260286973, 4234.026173979971, 32459.675403246136, 32761.508577371358, 32886.486162394, 33163.83418082918, 34400.31199376023, 4263.360495925605, 4322.351647252905, 4349.739015659039, 4372.409724687158, 4379.912401751979, 353118.0, 353944.99999999744, 354929.0, 356051.0, 358059.0, 52954.20568691473, 57673.711631441576, 57682.423175767704, 58353.416465835646, 58444.415555844746, 58032.70983645055, 64032.35967640264, 64070.67964660147, 64190.0, 64216.82590631594, 15208.771868421982, 15390.230488475532, 15418.0, 15428.691426171637, 15450.304736286895, 10418.68743937683, 11469.598564050219, 11626.128040396836, 11637.47631356591, 11647.242929209575, 16720.080395578116, 17051.403200887908, 17347.132643367782, 17569.0, 17634.91182544079, 6343.302236753953, 6481.624903190422, 6500.739970401226, 6596.142501474777, 6780.660966951633, 1003.4882210072915, 1032.5611615063717, 1062.3201151263197, 1069.6577095329576, 1142.440204299887, 33076.17309567232, 33112.50331245033, 33293.83353083268, 33359.49960750591, 33877.66122338794, 1114.8662160540787, 1123.3989815448697, 1129.6893354327626, 1136.9147313951487, 1260.7478504299177, 17117.657646846994, 17400.39098631567, 17413.738793918103, 17540.298388064333, 17569.385071522436, 535544.0, 536310.0, 537160.0, 537770.0, 541071.0, 58607.70696146492, 59898.40101598928, 60133.0, 60148.39851601516, 60223.698881506185, 1242.7576622558695, 1330.5609148980814, 1348.4606157537064, 1373.230990645242, 1381.896357773171, 31965.360692785547, 34222.0, 34618.48072278968, 34707.47938780971, 35185.296294073465, 51352.229716555026, 51591.0, 51942.48057519377, 52030.73984630052, 52082.479175207765, 410753.0, 412499.0, 413388.0, 414518.0, 415663.0, 35604.64395356013, 40756.388654170805, 41614.58385416107, 42010.579894200666, 44469.0, 48346.0, 49047.754761225966, 49450.0, 49659.503404966934, 50119.24821127759, 40867.59132408757, 41944.580554194064, 42204.0, 42529.14941701211, 43392.13215735604, 40694.0, 41218.58781412148, 41531.58468415398, 41537.792311038254, 41980.0, 42304.365434517895, 44407.55592444034, 44848.0, 45425.772871135436, 45484.77257613823, 39642.80178599089, 43995.0, 46106.308405373275, 46413.30380044234, 47350.0, 34485.0, 35584.82207588945, 35925.0, 36075.45886811752, 36328.63671363253], "value": 20514.936218798386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.54505820486315, 391.82172111689175, 392.9882103536894, 393.3333000564045, 409.66612211047993, 17367.218475168615, 19243.326483573077, 20576.176952921865, 20600.072996715146, 20610.484737881543, 18026.5493362666, 18171.0, 18188.81811181891, 18207.726884096715, 18510.537236569093, 5638.126090455976, 5839.649621022731, 5861.70691465425, 5909.4090590941, 5924.140999555062, 5700.9714951425185, 5823.767049318022, 5838.766449342022, 5857.092150716646, 5920.082387229986, 5642.4357564243455, 5654.321481422235, 5660.981023415804, 5784.1034639630925, 5786.045302525078, 5657.490825825675, 5686.346070201917, 5781.277340332437, 5794.333651630074, 5802.0, 5132.101882170605, 5165.380154381461, 5182.507661772163, 5242.082635538765, 5243.187305967581, 20307.0, 21405.14379424821, 21443.0, 22448.32655020352, 22682.54634907309, 2283.1209984156053, 2288.290629904735, 2308.5267520158327, 2487.6890388701413, 2984.925376865574, 10139.695809125664, 10148.492575371201, 10244.590216391336, 10392.896071039268, 10696.090832279266, 1905.1426857913993, 1972.9013549322476, 1987.6720341143694, 2012.275580790914, 2038.3375402993938, 68905.3109468909, 81105.18894811094, 81236.59381703053, 85440.14559854384, 86462.56768716179, 9006.864897026418, 9488.667896623585, 9650.469224192597, 9866.506674666238, 10016.599336026624, 13038.804417933548, 13143.60569182926, 13210.801837972438, 13249.072564920556, 13615.863841361657, 7290.161631412349, 7608.087029556378, 7726.497777644435, 7764.184760600168, 7819.061712594411, 6954.130733658293, 7015.36861682451, 7102.4318054555515, 7108.147022357351, 7134.215236324, 4676.69601475903, 4749.881252968704, 4764.237721964539, 4807.086653535817, 4810.470848206694, 1940.738000369932, 1943.1838627776367, 1945.0612509667753, 1972.7139564763315, 1984.6725290327222, 909.8862642169729, 917.6650522559218, 981.2444417798256, 1012.3520946594185, 1033.1579762493543, 18708.532286692942, 19135.80864191368, 19180.20494876281, 19473.51316217106, 19656.410307690792, 964.6479035152119, 982.8820541535061, 986.479544763137, 991.9752006199902, 1024.6106479537727, 9766.267529935141, 10796.622118225981, 10983.231173817916, 10984.286021408583, 11613.6515904523, 476755.0, 492079.0, 492530.0, 518068.0, 519227.0, 64954.051378458724, 93335.0, 101815.49092254491, 102434.48782756038, 103815.0, 1002.1431675917132, 1015.2334987084852, 1039.5010395010588, 1040.9271351005357, 1040.9375437473625, 17649.558761030563, 17940.282388704305, 18254.634907302046, 18313.450596482126, 18460.219940106632, 40902.1819563613, 41672.37491437692, 42285.36571951485, 42400.5759942409, 42674.64255321237, 58489.4151058484, 60206.698966506636, 60315.39684603098, 60623.393766061774, 60634.69682651559, 8531.189536993976, 8558.101399353227, 8627.87058194115, 8647.870281945901, 8727.083656216006, 12417.31704756247, 13220.603381898558, 13358.732825343634, 13384.799228011392, 13603.591892243248, 11933.582324618945, 12101.636950891487, 12252.326122063372, 12355.69110772238, 12356.320402377956, 11888.0, 11903.702407439883, 11936.0, 12025.0, 12029.338386388832, 12287.017038637066, 12412.255264684149, 12422.937885310515, 12439.626811195678, 12595.433205505591, 8378.120297368932, 8793.736187914374, 9003.459792412476, 9055.0, 9074.274058075207, 11844.822327665264, 12291.262524248574, 12303.0, 12306.138570299992, 12380.257184568954], "value": 9177.082579779619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.9284489353095, 1441.0777102654304, 1472.1093738288334, 1555.1602134847183, 1731.2036463226916, 7976.521408715481, 8288.378371622122, 8309.709160179387, 8509.276711479532, 8524.531150786705, 8212.466189697665, 8393.286570641503, 8394.748157555283, 8399.580020998956, 8416.537090460022, 2284.18911286493, 2312.236961802601, 2315.6294992801154, 2317.1079134533243, 2318.5131122464304, 2312.0520586559514, 2323.53529294141, 2366.810655147584, 2374.631932050535, 2377.643353496972, 2256.650219216024, 2263.366257447917, 2279.9772002280015, 2283.931482055541, 2300.022490441564, 2260.604394231011, 2275.169563109453, 2284.6116160252714, 2286.9885650571805, 2287.5310561334886, 2182.8253739700945, 2205.2943058221376, 2211.9225827095975, 2213.701150344699, 2214.5903007943584, 8138.430309878311, 8345.332373410112, 8389.370797190235, 8396.07643159258, 8396.832063358699, 4775.5701986821, 4948.925766113512, 4953.702777833306, 4960.925586116211, 4963.205887058053, 3136.231623252295, 3282.6224984126893, 3301.1417031571723, 3356.8825091121694, 3382.7632065755406, 1090.7218659241842, 1160.2864238493266, 1186.5669030803695, 1226.0865655086927, 1230.0405683566744, 11523.078153747763, 11701.53193872244, 11726.0, 11728.472218750092, 11774.646760597196, 4367.301231802896, 4502.099580083931, 4569.611583015414, 4604.263317869125, 4609.124266389375, 9978.950105249427, 9991.050850169368, 10026.0, 10040.347377420445, 10045.497725113715, 5007.974960125249, 5012.1980483122525, 5015.122353588107, 5020.573251273682, 5021.14640511114, 3919.451276821247, 3953.5453422856162, 4035.29382358092, 4503.504614492404, 4536.319552067216, 3806.904827379338, 3828.48315477407, 3894.3768996960353, 3923.725339226227, 3946.1910308387287, 1249.6875781054737, 1250.761137563769, 1255.466426768638, 1259.5528587351541, 1265.9430325635185, 825.7605294464659, 855.7304449098514, 918.5177781664546, 942.7878727286443, 944.7024187380953, 5591.832245032656, 5689.260396148474, 5713.971430142823, 5758.052315165068, 5809.2738407699035, 434.8369361489441, 442.50439507750883, 448.8473918867601, 450.34474839109015, 453.34718006071154, 4031.5968403160036, 4170.103427763045, 4181.540030596632, 4181.560936101726, 4234.830606775695, 10195.949020254851, 10234.334768240189, 10540.051395374454, 10540.894591053991, 10565.63020294286, 10300.587976480856, 10376.962303769562, 10434.843477347846, 10442.269041167045, 10458.581656733646, 7777.261160189773, 7851.097123830718, 7949.125596184415, 8004.399670024655, 8011.158828322942, 5451.64564303319, 5617.662940223599, 5672.744726487401, 5683.261176047087, 5704.1443783432815, 9243.121903419164, 9566.856497152408, 9594.04059594035, 9680.225581953568, 9796.559154838193, 9467.857982130135, 9885.604575816888, 9892.109710126124, 10047.497625118569, 10087.69736907894, 6892.207396149306, 6972.09362782835, 7132.037174981519, 7447.404207663482, 7577.052868391451, 7992.560409177551, 7995.760127196193, 8075.919240807517, 8090.797730056795, 8098.392620553364, 7172.856542869218, 7309.5248808827255, 7316.048913641405, 7493.550386976799, 7500.587467689329, 7078.858422831618, 7096.680649370687, 7147.3210045045635, 7261.056062711814, 7327.63361831917, 6615.338466153346, 6681.5656982296, 6682.69927853238, 6727.966360168168, 6741.393274605309, 4904.215325547895, 5068.898622027613, 5113.64204505681, 5129.640925135204, 5142.665726727751, 4986.8753281168265, 5027.84916452507, 5042.369703787027, 5113.51421614946, 5164.509371609691], "value": 4384.74684092175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.8087147711374, 330.1564502695613, 331.99336013279736, 335.414701346151, 336.5826375294635, 5101.209312556551, 5139.229115632657, 5243.790248390064, 5266.605004624654, 5270.209468579715, 5200.271961925334, 5228.372595288562, 5244.449332820056, 5245.86885327867, 5257.211418287249, 4129.504459464868, 4138.358554424069, 4153.252414565377, 4157.625813676768, 4167.916641667165, 3932.233214523169, 3942.4283478895545, 4118.938215926763, 4149.917001659965, 4165.104502531955, 4093.8771836844944, 4113.856015039474, 4126.988887722498, 4129.256733787917, 4141.399497072923, 4094.1197642507004, 4095.1604920991126, 4108.726294848577, 4115.218108559364, 4126.607972242662, 3510.297940411928, 3653.3058718843336, 3668.4313931340685, 3674.1365779041903, 3675.7059435245383, 5071.923921141186, 5078.695278283315, 5084.51697088776, 5093.9812037592255, 5102.081625307444, 4690.179218636759, 4714.787834547454, 4744.217204161309, 4776.23580227162, 4783.4977327380475, 5270.604704647167, 5430.266913966603, 5436.537894278991, 5462.371827239878, 5488.341399032101, 4057.3102572562734, 4060.822361515157, 4070.0463777386726, 4072.124493233939, 4073.490813648294, 5677.858053548653, 5704.515116215127, 5713.657180569179, 5743.913841292384, 5754.510866576388, 3934.409838524187, 4146.523149837807, 4166.395872598457, 4175.519815221289, 4180.916381672349, 4188.790560471964, 4199.454070970754, 4216.430781844411, 4230.471191101113, 4233.1322078973735, 4729.864832440189, 4733.14803335396, 4733.148033354029, 4740.525947405301, 4769.165396055676, 5247.291615631917, 5509.3664228614225, 5510.256115424447, 5520.944790552124, 5546.389897111315, 1389.0, 1422.6087825847974, 1433.6953372431037, 1442.451868290043, 1447.3848614339074, 936.9109934556207, 940.2571968145226, 958.501579178837, 961.7209111881182, 969.9030096990244, 4519.41247637805, 4621.0, 4633.351330813689, 4652.744099074584, 4681.204195286809, 4887.828925987574, 4895.339129217581, 4908.509149085135, 4927.472483530117, 4936.951165266446, 4570.360149579062, 4619.745913974763, 4693.718376897397, 4753.191957367256, 4765.189917713997, 2655.2830735701637, 2686.771624411908, 2693.9326516836845, 2698.2984424049887, 2707.76983956362, 5067.746612669352, 5091.956148989522, 5108.310378098983, 5111.846644600668, 5116.692998420107, 4700.0, 5016.724080175552, 5041.747912604355, 5048.29323894655, 5061.621038112082, 5079.2381142828135, 5113.002964421902, 5128.538431541179, 5129.076766182123, 5135.6405051646025, 4929.69363118781, 4950.836553409874, 4960.0, 4966.6771659842, 4969.975150124226, 4909.533594308535, 4917.549322949667, 4945.357103576512, 5195.272661827272, 5616.7191640416995, 5849.824505264849, 5860.355360910211, 5865.618734782225, 5876.0, 5887.793927212527, 4062.5531191569494, 4074.0851799654115, 4084.8366065357054, 4086.8773936781945, 4094.2630326541507, 5341.97329013368, 5372.006178856924, 5524.1989911463415, 5723.454667239738, 5737.282839645044, 5497.47773961473, 5499.7250137492165, 5515.531179849758, 5515.751791169327, 5523.558115350843, 5509.0, 5520.392756796829, 5521.0, 5546.195801608664, 5561.499465048003, 5212.765425555935, 5364.517193452608, 5397.920415916754, 5408.8377348679605, 5423.888102938967, 5509.696966666712, 5539.695316757617, 5553.500184983371, 5557.777688892399, 5574.996500629925, 5313.661988724949, 5375.220593014069, 5401.729913504388, 5420.457954204548, 5460.535854452257], "value": 4091.210168221712, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.2139364364239, 773.8955241042459, 784.3372350363941, 798.1260519730893, 828.9751307460779, 14245.216513091777, 15444.61388465289, 15654.295556699948, 15760.921195394007, 15852.0, 14610.123392596452, 15111.395544178247, 15225.695486090272, 15839.445619403323, 15853.20733963303, 658.4600627485464, 777.6306254529081, 801.1627848897915, 803.1968031968032, 809.6558962440969, 797.8484088023285, 806.1253539909205, 806.31060443321, 808.737160422862, 809.0776514773163, 846.6147902704286, 847.4406891451644, 848.9108643592426, 851.0383266908385, 851.1190917400492, 691.882379995402, 825.6202147012382, 840.8024114333127, 844.543946269014, 844.9746507604751, 621.7761605821901, 621.9502439804804, 622.4366947912147, 622.7384498510636, 623.0560700538642, 14247.358868850926, 14284.214368209745, 14356.569302920929, 14373.137611743328, 14411.639709007253, 13775.517856874962, 14213.289335533182, 14221.857781422157, 14341.21123338216, 14404.351804168837, 12085.733075589456, 12148.514059437612, 12259.816102758467, 12344.259344439362, 12404.25574465526, 4373.365861950031, 4433.290673492225, 4468.262736648449, 4539.795709193094, 4661.766911654404, 68177.0, 68888.0, 69791.65104174498, 71346.64326678385, 71381.64309178421, 10705.892941070646, 10790.89209107899, 10850.348979061124, 10865.293755906, 11313.094952403788, 21323.0, 21340.359789206348, 21346.466338341666, 21388.251411200534, 21428.89285553562, 8507.489550626982, 8525.360597955178, 8583.141685831491, 8669.783255418539, 8758.080401557745, 4576.382188404589, 4643.95356046442, 4677.18149323867, 4722.95277047232, 4771.73755443447, 3553.3071051145293, 3624.1120925373452, 3647.6534729200685, 3672.1003354178397, 3677.889663310105, 553.3221803291017, 563.7463141586303, 568.5536853569928, 582.912563115536, 587.0577722754916, 615.4676205082571, 668.1280928388403, 671.4863129705778, 673.5016088094775, 696.502001069238, 9346.57940392684, 9835.529736877192, 9854.0, 9862.42201247797, 9997.300188986846, 579.3241880269682, 604.8094850122197, 662.8276648071536, 678.1827897383641, 679.5277282288762, 4523.424878836839, 4636.4436267647425, 4659.440867095903, 4766.331783875685, 4865.6107511399005, 69832.0, 99240.0, 103280.48359758154, 105426.47286763517, 107148.4642576782, 69444.30555694379, 96793.51603241939, 96920.51539742257, 99330.5033474828, 101017.0, 53048.73475632597, 78014.60992695113, 83015.0, 83369.16630833736, 83442.0, 8980.685676001309, 9149.013065067837, 9169.954150229207, 9235.12266334697, 9288.72133835986, 51023.74488127536, 52239.21641175461, 52427.21359179691, 52495.73752131215, 52997.205041925175, 68773.65613171902, 69700.0, 73016.26983730095, 74582.62708686422, 75518.0, 11529.308241505536, 11592.88407115918, 11675.532978680758, 11877.46551405206, 11887.0, 12612.747745044864, 12632.2420654761, 12869.678258043623, 12887.097903147065, 13027.934860325639, 12033.578824741093, 12069.10238345672, 12585.559505417266, 12688.746225075261, 12769.61691149267, 11969.820452693042, 12023.879761202275, 12127.222778708607, 12235.93882030584, 12527.31099789484, 11468.254563453349, 11625.825612615648, 11995.880041199476, 12269.69325766863, 12283.447244874182, 9609.0, 9819.705408837746, 10069.597216111273, 10214.591416343561, 10250.38497690141, 10093.343932644355, 10308.208240178725, 10466.0, 10541.78916421652, 10570.682879513626], "value": 7261.062529517002, "unit": "score"}], "name": "dromaeo_css", "value": 7098.260627517508, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 106.0, 109.0, 109.0, 110.0, 109.0, 110.0, 114.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 130.0, 178.0, 129.0, 126.0, 150.0, 125.0, 165.0, 125.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 162.0, 163.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 156.0, 75.0, 77.0, 75.0, 76.0, 122.0, 73.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 124.0, 86.0, 85.0, 85.0, 123.0, 85.0, 86.0, 131.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 54.0, 57.0, 52.0, 54.0, 53.0, 52.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 62.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 84.0, 86.0, 83.0, 80.0, 81.0, 121.0, 81.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 127.0, 119.0, 118.0, 121.0, 127.0, 121.0, 134.0, 123.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 161.0, 165.0, 163.0, 158.0, 160.0, 157.0, 159.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 64.0, 62.0, 67.0, 65.0, 63.0, 62.0, 62.0, 67.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1501.0000000000002, "alertThreshold": 2.0}]} 17:24:19 INFO - Return code: 0 17:24:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:24:19 INFO - # TBPL SUCCESS # 17:24:19 INFO - Running post-action listener: _resource_record_post_action 17:24:19 INFO - ##### 17:24:19 INFO - ##### Finished run-tests step (success) 17:24:19 INFO - ##### 17:24:19 INFO - Running post-run listener: _resource_record_post_run 17:24:19 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 541224960; Read time: 0; Write time: 613564 17:24:19 INFO - TinderboxPrint: CPU usage
13.2% 17:24:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:24:19 INFO - TinderboxPrint: I/O write bytes / time
541,224,960 / 613,564 17:24:19 INFO - TinderboxPrint: CPU idle
8,257.8 (86.7%) 17:24:19 INFO - TinderboxPrint: CPU user
1,212.1 (12.7%) 17:24:19 INFO - TinderboxPrint: Swap in / out
0 / 0 17:24:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248815616; Read time: 0; Write time: 390752 17:24:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 292409344; Read time: 0; Write time: 222812 17:24:19 INFO - Running post-run listener: _upload_blobber_files 17:24:19 INFO - Blob upload gear active. 17:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:24:19 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'] 17:24:19 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 17:24:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:20 INFO - (blobuploader) - INFO - Done attempting. 17:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:21 INFO - (blobuploader) - INFO - Done attempting. 17:24:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:24:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:25 INFO - (blobuploader) - INFO - Done attempting. 17:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:25 INFO - Return code: 0 17:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22045f6ae540cfdc0ee33537ac2e1825fd3daf62e374720ad4de06bc18081e689ad70c61116bfcfa5194ef05fc56719d4a633ac0e282fa592999c9f398592b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06647ceb276501f024c70f93a665609ab9995a18d7fefda6cf4a814a7ee7d6d2bdd93b755f31ec54624c667cb0ad8fa0f9b635b219f916ee619dd6ac5073e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa197f8e48eae062a922df6bc4e86a011b292ad487b9628a7fb58c018ec302c1aa563d92d12014ccb217c99a7e15b241fa6584da7d70f149d236d3246c9afd71"} 17:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:25 INFO - Contents: 17:24:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22045f6ae540cfdc0ee33537ac2e1825fd3daf62e374720ad4de06bc18081e689ad70c61116bfcfa5194ef05fc56719d4a633ac0e282fa592999c9f398592b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06647ceb276501f024c70f93a665609ab9995a18d7fefda6cf4a814a7ee7d6d2bdd93b755f31ec54624c667cb0ad8fa0f9b635b219f916ee619dd6ac5073e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa197f8e48eae062a922df6bc4e86a011b292ad487b9628a7fb58c018ec302c1aa563d92d12014ccb217c99a7e15b241fa6584da7d70f149d236d3246c9afd71"} 17:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:25 INFO - Copying logs to upload dir... 17:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.592974 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-10 17:24:25.581106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 17:24:25.585002) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 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/22045f6ae540cfdc0ee33537ac2e1825fd3daf62e374720ad4de06bc18081e689ad70c61116bfcfa5194ef05fc56719d4a633ac0e282fa592999c9f398592b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06647ceb276501f024c70f93a665609ab9995a18d7fefda6cf4a814a7ee7d6d2bdd93b755f31ec54624c667cb0ad8fa0f9b635b219f916ee619dd6ac5073e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa197f8e48eae062a922df6bc4e86a011b292ad487b9628a7fb58c018ec302c1aa563d92d12014ccb217c99a7e15b241fa6584da7d70f149d236d3246c9afd71"} build_url:https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/NAWhFz28Qk6Nr5ygPshQYQ/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/22045f6ae540cfdc0ee33537ac2e1825fd3daf62e374720ad4de06bc18081e689ad70c61116bfcfa5194ef05fc56719d4a633ac0e282fa592999c9f398592b7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c06647ceb276501f024c70f93a665609ab9995a18d7fefda6cf4a814a7ee7d6d2bdd93b755f31ec54624c667cb0ad8fa0f9b635b219f916ee619dd6ac5073e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa197f8e48eae062a922df6bc4e86a011b292ad487b9628a7fb58c018ec302c1aa563d92d12014ccb217c99a7e15b241fa6584da7d70f149d236d3246c9afd71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 17:24:25.612605) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:24:25.612943) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465601937.855248-1046466816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 17:24:25.695457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 17:24:25.695862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 17:24:25.696224) ========= ========= Total master_lag: 0.16 =========