builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1466590359.86 results: success (0) buildid: 20160622024801 builduid: 4eb963d017df4cf3ae13ca969ffbd51e revision: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.859227) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.859629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.859897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.891020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:39.891476) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 03:12: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-06-22 03:12:40 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185970 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.114965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.115304) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022004 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.175090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.175442) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f --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 ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f --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=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 03:12:40,252 truncating revision to first 12 chars 2016-06-22 03:12:40,252 Setting DEBUG logging. 2016-06-22 03:12:40,252 attempt 1/10 2016-06-22 03:12:40,252 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ee2eba8cdedd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 03:12:40,568 unpacking tar archive at: fx-team-ee2eba8cdedd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.865190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.865484) ========= script_repo_revision: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.865877) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.866157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 03:12:40.913328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-22 03:12:40.913762) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:12:41 INFO - MultiFileLogger online at 20160622 03:12:41 in /builds/slave/test 03:12:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:41 INFO - {'append_to_log': False, 03:12:41 INFO - 'base_work_dir': '/builds/slave/test', 03:12:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:41 INFO - 'branch': 'Fx-Team-Non-PGO', 03:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:41 INFO - 'config_files': ('talos/linux_config.py',), 03:12:41 INFO - 'default_actions': ('clobber', 03:12:41 INFO - 'read-buildbot-config', 03:12:41 INFO - 'download-and-extract', 03:12:41 INFO - 'populate-webroot', 03:12:41 INFO - 'create-virtualenv', 03:12:41 INFO - 'install', 03:12:41 INFO - 'run-tests'), 03:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:41 INFO - 'download_minidump_stackwalk': True, 03:12:41 INFO - 'download_symbols': 'ondemand', 03:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:41 INFO - 'installer_path': 'installer.exe', 03:12:41 INFO - 'log_level': 'info', 03:12:41 INFO - 'log_name': 'talos', 03:12:41 INFO - 'log_to_console': True, 03:12:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:12:41 INFO - 'opt_config_files': (), 03:12:41 INFO - 'pip_index': False, 03:12:41 INFO - 'sps_profile': False, 03:12:41 INFO - 'sps_profile_interval': 0, 03:12:41 INFO - 'suite': 'dromaeojs-e10s', 03:12:41 INFO - 'system_bits': '32', 03:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:41 INFO - 'title': 'talos-linux64-ix-015', 03:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:41 INFO - 'use_talos_json': True, 03:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:41 INFO - 'work_dir': 'build'} 03:12:41 INFO - ##### 03:12:41 INFO - ##### Running clobber step. 03:12:41 INFO - ##### 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: clobber 03:12:41 INFO - rmtree: /builds/slave/test/build 03:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:41 INFO - Running post-action listener: _resource_record_post_action 03:12:41 INFO - ##### 03:12:41 INFO - ##### Finished clobber step (success) 03:12:41 INFO - ##### 03:12:41 INFO - ##### 03:12:41 INFO - ##### Running read-buildbot-config step. 03:12:41 INFO - ##### 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: read_buildbot_config 03:12:41 INFO - Using buildbot properties: 03:12:41 INFO - { 03:12:41 INFO - "project": "", 03:12:41 INFO - "product": "firefox", 03:12:41 INFO - "script_repo_revision": "production", 03:12:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:12:41 INFO - "repository": "", 03:12:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:12:41 INFO - "buildid": "20160622024801", 03:12:41 INFO - "pgo_build": "False", 03:12:41 INFO - "basedir": "/builds/slave/test", 03:12:41 INFO - "buildnumber": 1602, 03:12:41 INFO - "slavename": "talos-linux64-ix-015", 03:12:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:12:41 INFO - "platform": "ubuntu64_hw", 03:12:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:12:41 INFO - "branch": "fx-team", 03:12:41 INFO - "repo_path": "integration/fx-team", 03:12:41 INFO - "revision": "ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f", 03:12:41 INFO - "stage_platform": "linux64", 03:12:41 INFO - "builduid": "4eb963d017df4cf3ae13ca969ffbd51e", 03:12:41 INFO - "slavebuilddir": "test" 03:12:41 INFO - } 03:12:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:12:41 INFO - Running post-action listener: _resource_record_post_action 03:12:41 INFO - ##### 03:12:41 INFO - ##### Finished read-buildbot-config step (success) 03:12:41 INFO - ##### 03:12:41 INFO - ##### 03:12:41 INFO - ##### Running download-and-extract step. 03:12:41 INFO - ##### 03:12:41 INFO - Running pre-action listener: _resource_record_pre_action 03:12:41 INFO - Running main action method: download_and_extract 03:12:41 INFO - mkdir: /builds/slave/test/build/tests 03:12: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')]} 03:12:41 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:12:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:51 INFO - Downloaded 1361 bytes. 03:12:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:12:51 INFO - Using the following test package requirements: 03:12:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:12:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:12:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'jsshell-linux-x86_64.zip'], 03:12:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:12:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:12:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:12:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:12:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:12:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:12:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:12:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:51 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:12:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:00 INFO - Downloaded 22702379 bytes. 03:13:00 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'] 03:13:00 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 03:13:01 INFO - Return code: 0 03:13:01 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 03:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:01 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:04 INFO - Downloaded 22702379 bytes. 03:13:04 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'] 03:13:04 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 03:13:06 INFO - Return code: 0 03:13: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')]} 03:13:06 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:07 INFO - Downloaded 14405384 bytes. 03:13:07 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'] 03:13:07 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 03:13:08 INFO - Return code: 0 03:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:08 INFO - https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VJm5rOAwSOa2TvVjr2aZIw/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 03:13:09 INFO - Downloaded 56247199 bytes. 03:13:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:09 INFO - mkdir: /builds/slave/test/properties 03:13:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:13:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:13:09 INFO - Contents: 03:13:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:13:10 INFO - Running post-action listener: _resource_record_post_action 03:13:10 INFO - Running post-action listener: set_extra_try_arguments 03:13:10 INFO - ##### 03:13:10 INFO - ##### Finished download-and-extract step (success) 03:13:10 INFO - ##### 03:13:10 INFO - ##### 03:13:10 INFO - ##### Running populate-webroot step. 03:13:10 INFO - ##### 03:13:10 INFO - Running pre-action listener: _resource_record_pre_action 03:13:10 INFO - Running main action method: populate_webroot 03:13:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:13:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:13:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:13:10 INFO - '--tppagecycles', 03:13:10 INFO - '7'], 03:13:10 INFO - 'tests': ['tsvgm']}}, 03:13:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:13:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:13:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:13:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:13:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['damp', 'tps']}, 03:13:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'tests': ['damp', 'tps']}, 03:13:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['dromaeo_dom']}, 03:13:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['basic_compositor_video']}, 03:13:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:13:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['a11yr', 03:13:10 INFO - 'ts_paint', 03:13:10 INFO - 'tpaint', 03:13:10 INFO - 'sessionrestore', 03:13:10 INFO - 'sessionrestore_no_auto_restore', 03:13:10 INFO - 'tabpaint']}, 03:13:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['tsvgx', 03:13:10 INFO - 'tsvgr_opacity', 03:13:10 INFO - 'tart', 03:13:10 INFO - 'tscrollx', 03:13:10 INFO - 'cart']}, 03:13:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:13:10 INFO - 'tsvgr_opacity', 03:13:10 INFO - 'tart', 03:13:10 INFO - 'tscrollx', 03:13:10 INFO - 'cart']}, 03:13:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'talos_options': ['--disable-e10s'], 03:13:10 INFO - 'tests': ['tp5o']}, 03:13:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'tests': ['tp5o']}, 03:13:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'talos_options': ['--disable-e10s', 03:13:10 INFO - '--xperf_path', 03:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:10 INFO - 'tests': ['tp5n']}, 03:13:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:10 INFO - 'talos_options': ['--xperf_path', 03:13:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:10 INFO - 'tests': ['tp5n']}}, 03:13:10 INFO - 'talos.zip': {'path': '', 03:13:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:13:10 INFO - Running post-action listener: _resource_record_post_action 03:13:10 INFO - ##### 03:13:10 INFO - ##### Finished populate-webroot step (success) 03:13:10 INFO - ##### 03:13:10 INFO - ##### 03:13:10 INFO - ##### Running create-virtualenv step. 03:13:10 INFO - ##### 03:13:10 INFO - Running pre-action listener: _resource_record_pre_action 03:13:10 INFO - Running main action method: create_virtualenv 03:13:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:13:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:13:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:13:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:10 INFO - Using real prefix '/usr' 03:13:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:13:11 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:13 INFO - Installing pip.................done. 03:13:13 INFO - Return code: 0 03:13:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:13 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:13:13 INFO - Using env: {'DISPLAY': ':0', 03:13:13 INFO - 'HOME': '/home/cltbld', 03:13:13 INFO - 'LANG': 'en_US.UTF-8', 03:13:13 INFO - 'LANGUAGE': 'en_US:en', 03:13:13 INFO - 'LOGNAME': 'cltbld', 03:13:13 INFO - 'MAIL': '/var/mail/cltbld', 03:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:13 INFO - 'MOZ_NO_REMOTE': '1', 03:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:13 INFO - 'NO_EM_RESTART': '1', 03:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:13 INFO - 'PWD': '/builds/slave/test', 03:13:13 INFO - 'SHELL': '/bin/bash', 03:13:13 INFO - 'SHLVL': '1', 03:13:13 INFO - 'TERM': 'linux', 03:13:13 INFO - 'TMOUT': '86400', 03:13:13 INFO - 'USER': 'cltbld', 03:13:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:13 INFO - '_': '/tools/buildbot/bin/python'} 03:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:13:14 INFO - Cleaning up... 03:13:14 INFO - Return code: 0 03:13:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:14 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:14 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 03:13:14 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 03:13:14 INFO - Using env: {'DISPLAY': ':0', 03:13:14 INFO - 'HOME': '/home/cltbld', 03:13:14 INFO - 'LANG': 'en_US.UTF-8', 03:13:14 INFO - 'LANGUAGE': 'en_US:en', 03:13:14 INFO - 'LOGNAME': 'cltbld', 03:13:14 INFO - 'MAIL': '/var/mail/cltbld', 03:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:14 INFO - 'MOZ_NO_REMOTE': '1', 03:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:14 INFO - 'NO_EM_RESTART': '1', 03:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:14 INFO - 'PWD': '/builds/slave/test', 03:13:14 INFO - 'SHELL': '/bin/bash', 03:13:14 INFO - 'SHLVL': '1', 03:13:14 INFO - 'TERM': 'linux', 03:13:14 INFO - 'TMOUT': '86400', 03:13:14 INFO - 'USER': 'cltbld', 03:13:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:14 INFO - '_': '/tools/buildbot/bin/python'} 03:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:14 INFO - Downloading/unpacking psutil>=3.1.1 03:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:16 INFO - Installing collected packages: psutil 03:13:16 INFO - Running setup.py install for psutil 03:13:16 INFO - building 'psutil._psutil_linux' extension 03:13:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:13:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:13:18 INFO - building 'psutil._psutil_posix' extension 03:13:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:13:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:13:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:18 INFO - Successfully installed psutil 03:13:18 INFO - Cleaning up... 03:13:19 INFO - Return code: 0 03:13:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:19 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:19 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 03:13:19 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 03:13:19 INFO - Using env: {'DISPLAY': ':0', 03:13:19 INFO - 'HOME': '/home/cltbld', 03:13:19 INFO - 'LANG': 'en_US.UTF-8', 03:13:19 INFO - 'LANGUAGE': 'en_US:en', 03:13:19 INFO - 'LOGNAME': 'cltbld', 03:13:19 INFO - 'MAIL': '/var/mail/cltbld', 03:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:19 INFO - 'MOZ_NO_REMOTE': '1', 03:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:19 INFO - 'NO_EM_RESTART': '1', 03:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:19 INFO - 'PWD': '/builds/slave/test', 03:13:19 INFO - 'SHELL': '/bin/bash', 03:13:19 INFO - 'SHLVL': '1', 03:13:19 INFO - 'TERM': 'linux', 03:13:19 INFO - 'TMOUT': '86400', 03:13:19 INFO - 'USER': 'cltbld', 03:13:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:19 INFO - '_': '/tools/buildbot/bin/python'} 03:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:13:21 INFO - Installing collected packages: mozsystemmonitor 03:13:21 INFO - Running setup.py install for mozsystemmonitor 03:13:21 INFO - Successfully installed mozsystemmonitor 03:13:21 INFO - Cleaning up... 03:13:21 INFO - Return code: 0 03:13:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13: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==2.5.1'] in /builds/slave/test/build 03:13: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==2.5.1 03:13:21 INFO - Using env: {'DISPLAY': ':0', 03:13:21 INFO - 'HOME': '/home/cltbld', 03:13:21 INFO - 'LANG': 'en_US.UTF-8', 03:13:21 INFO - 'LANGUAGE': 'en_US:en', 03:13:21 INFO - 'LOGNAME': 'cltbld', 03:13:21 INFO - 'MAIL': '/var/mail/cltbld', 03:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:21 INFO - 'MOZ_NO_REMOTE': '1', 03:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:21 INFO - 'NO_EM_RESTART': '1', 03:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:21 INFO - 'PWD': '/builds/slave/test', 03:13:21 INFO - 'SHELL': '/bin/bash', 03:13:21 INFO - 'SHLVL': '1', 03:13:21 INFO - 'TERM': 'linux', 03:13:21 INFO - 'TMOUT': '86400', 03:13:21 INFO - 'USER': 'cltbld', 03:13:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:21 INFO - '_': '/tools/buildbot/bin/python'} 03:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:13:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:13:23 INFO - warning: no files found matching '*.txt' 03:13:23 INFO - no previously-included directories found matching 'build' 03:13:23 INFO - no previously-included directories found matching 'dist' 03:13:23 INFO - no previously-included directories found matching '.git*' 03:13:23 INFO - Installing collected packages: jsonschema, functools32 03:13:23 INFO - Running setup.py install for functools32 03:13:23 INFO - warning: no files found matching '*.txt' 03:13:23 INFO - no previously-included directories found matching 'build' 03:13:23 INFO - no previously-included directories found matching 'dist' 03:13:23 INFO - no previously-included directories found matching '.git*' 03:13:23 INFO - Successfully installed jsonschema functools32 03:13:23 INFO - Cleaning up... 03:13:23 INFO - Return code: 0 03:13:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:23 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:13:23 INFO - Using env: {'DISPLAY': ':0', 03:13:23 INFO - 'HOME': '/home/cltbld', 03:13:23 INFO - 'LANG': 'en_US.UTF-8', 03:13:23 INFO - 'LANGUAGE': 'en_US:en', 03:13:23 INFO - 'LOGNAME': 'cltbld', 03:13:23 INFO - 'MAIL': '/var/mail/cltbld', 03:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:23 INFO - 'MOZ_NO_REMOTE': '1', 03:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:23 INFO - 'NO_EM_RESTART': '1', 03:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:23 INFO - 'PWD': '/builds/slave/test', 03:13:23 INFO - 'SHELL': '/bin/bash', 03:13:23 INFO - 'SHLVL': '1', 03:13:23 INFO - 'TERM': 'linux', 03:13:23 INFO - 'TMOUT': '86400', 03:13:23 INFO - 'USER': 'cltbld', 03:13:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:23 INFO - '_': '/tools/buildbot/bin/python'} 03:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:26 INFO - Downloading docopt-0.6.1.tar.gz 03:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:26 INFO - Running setup.py install for blobuploader 03:13:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:26 INFO - Running setup.py install for requests 03:13:27 INFO - Running setup.py install for docopt 03:13:27 INFO - Successfully installed blobuploader requests docopt 03:13:27 INFO - Cleaning up... 03:13:27 INFO - Return code: 0 03:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:27 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:27 INFO - Using env: {'DISPLAY': ':0', 03:13:27 INFO - 'HOME': '/home/cltbld', 03:13:27 INFO - 'LANG': 'en_US.UTF-8', 03:13:27 INFO - 'LANGUAGE': 'en_US:en', 03:13:27 INFO - 'LOGNAME': 'cltbld', 03:13:27 INFO - 'MAIL': '/var/mail/cltbld', 03:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:27 INFO - 'MOZ_NO_REMOTE': '1', 03:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:27 INFO - 'NO_EM_RESTART': '1', 03:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:27 INFO - 'PWD': '/builds/slave/test', 03:13:27 INFO - 'SHELL': '/bin/bash', 03:13:27 INFO - 'SHLVL': '1', 03:13:27 INFO - 'TERM': 'linux', 03:13:27 INFO - 'TMOUT': '86400', 03:13:27 INFO - 'USER': 'cltbld', 03:13:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:27 INFO - '_': '/tools/buildbot/bin/python'} 03:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:27 INFO - Running setup.py (path:/tmp/pip-V4Dgi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:27 INFO - Running setup.py (path:/tmp/pip-REgQ78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:27 INFO - Running setup.py (path:/tmp/pip-vU0Q4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:27 INFO - Running setup.py (path:/tmp/pip-ZxDntE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:27 INFO - Running setup.py (path:/tmp/pip-s1T8gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:27 INFO - Running setup.py (path:/tmp/pip-DdZ_zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:28 INFO - Running setup.py (path:/tmp/pip-Ale6uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:28 INFO - Running setup.py (path:/tmp/pip-f9Rt9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:28 INFO - Running setup.py (path:/tmp/pip-mqPgJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:28 INFO - Running setup.py (path:/tmp/pip-9voFK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:28 INFO - Running setup.py (path:/tmp/pip-Kaa481-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:28 INFO - Running setup.py (path:/tmp/pip-04_tDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:28 INFO - Running setup.py (path:/tmp/pip-y8ytUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:28 INFO - Running setup.py (path:/tmp/pip-tRWofU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:28 INFO - Running setup.py (path:/tmp/pip-ym3vLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:28 INFO - Running setup.py (path:/tmp/pip-HuDdca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:28 INFO - Running setup.py (path:/tmp/pip-R_8wLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:28 INFO - Running setup.py install for manifestparser 03:13:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:28 INFO - Running setup.py install for mozcrash 03:13:29 INFO - Running setup.py install for mozdebug 03:13:29 INFO - Running setup.py install for mozdevice 03:13:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for mozfile 03:13:29 INFO - Running setup.py install for mozhttpd 03:13:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for mozinfo 03:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for mozInstall 03:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for mozleak 03:13:29 INFO - Running setup.py install for mozlog 03:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for moznetwork 03:13:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:29 INFO - Running setup.py install for mozprocess 03:13:30 INFO - Running setup.py install for mozprofile 03:13:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:30 INFO - Running setup.py install for mozrunner 03:13:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:30 INFO - Running setup.py install for mozscreenshot 03:13:30 INFO - Running setup.py install for moztest 03:13:30 INFO - Running setup.py install for mozversion 03:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:30 INFO - Cleaning up... 03:13:30 INFO - Return code: 0 03:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:30 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:30 INFO - Using env: {'DISPLAY': ':0', 03:13:30 INFO - 'HOME': '/home/cltbld', 03:13:30 INFO - 'LANG': 'en_US.UTF-8', 03:13:30 INFO - 'LANGUAGE': 'en_US:en', 03:13:30 INFO - 'LOGNAME': 'cltbld', 03:13:30 INFO - 'MAIL': '/var/mail/cltbld', 03:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:30 INFO - 'MOZ_NO_REMOTE': '1', 03:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:30 INFO - 'NO_EM_RESTART': '1', 03:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:30 INFO - 'PWD': '/builds/slave/test', 03:13:30 INFO - 'SHELL': '/bin/bash', 03:13:30 INFO - 'SHLVL': '1', 03:13:30 INFO - 'TERM': 'linux', 03:13:30 INFO - 'TMOUT': '86400', 03:13:30 INFO - 'USER': 'cltbld', 03:13:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:30 INFO - '_': '/tools/buildbot/bin/python'} 03:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:30 INFO - Running setup.py (path:/tmp/pip-sD31Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:30 INFO - Running setup.py (path:/tmp/pip-w9rBR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:30 INFO - Running setup.py (path:/tmp/pip-E0OVGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:31 INFO - Running setup.py (path:/tmp/pip-bMVhYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:31 INFO - Running setup.py (path:/tmp/pip-BIACTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:31 INFO - Running setup.py (path:/tmp/pip-5cYe0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:31 INFO - Running setup.py (path:/tmp/pip-wuavpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:31 INFO - Running setup.py (path:/tmp/pip-WzKQeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:31 INFO - Running setup.py (path:/tmp/pip-taC6Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:31 INFO - Running setup.py (path:/tmp/pip-poe3YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:31 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)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:31 INFO - Running setup.py (path:/tmp/pip-3wKZ2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:31 INFO - Running setup.py (path:/tmp/pip-gImInr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:31 INFO - Running setup.py (path:/tmp/pip-wxA1OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:31 INFO - Running setup.py (path:/tmp/pip-4zH3Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:31 INFO - Running setup.py (path:/tmp/pip-4Ijk0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:31 INFO - Running setup.py (path:/tmp/pip-whFkok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:32 INFO - Running setup.py (path:/tmp/pip-Ffmp2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:33 INFO - Downloading blessings-1.6.tar.gz 03:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:34 INFO - Installing collected packages: blessings 03:13:34 INFO - Running setup.py install for blessings 03:13:34 INFO - Successfully installed blessings 03:13:34 INFO - Cleaning up... 03:13:34 INFO - Return code: 0 03:13:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:34 INFO - Reading from file tmpfile_stdout 03:13:34 INFO - Current package versions: 03:13:34 INFO - argparse == 1.2.1 03:13:34 INFO - blessings == 1.6 03:13:34 INFO - blobuploader == 1.2.4 03:13:34 INFO - docopt == 0.6.1 03:13:34 INFO - functools32 == 3.2.3-2 03:13:34 INFO - jsonschema == 2.5.1 03:13:34 INFO - manifestparser == 1.1 03:13:34 INFO - mozInstall == 1.12 03:13:34 INFO - mozcrash == 0.17 03:13:34 INFO - mozdebug == 0.1 03:13:34 INFO - mozdevice == 0.48 03:13:34 INFO - mozfile == 1.2 03:13:34 INFO - mozhttpd == 0.7 03:13:34 INFO - mozinfo == 0.9 03:13:34 INFO - mozleak == 0.1 03:13:34 INFO - mozlog == 3.2 03:13:34 INFO - moznetwork == 0.27 03:13:34 INFO - mozprocess == 0.22 03:13:34 INFO - mozprofile == 0.28 03:13:34 INFO - mozrunner == 6.11 03:13:34 INFO - mozscreenshot == 0.1 03:13:34 INFO - mozsystemmonitor == 0.3 03:13:34 INFO - moztest == 0.7 03:13:34 INFO - mozversion == 1.4 03:13:34 INFO - psutil == 3.1.1 03:13:34 INFO - requests == 1.2.3 03:13:34 INFO - wsgiref == 0.1.2 03:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:13:34 INFO - Using env: {'DISPLAY': ':0', 03:13:34 INFO - 'HOME': '/home/cltbld', 03:13:34 INFO - 'LANG': 'en_US.UTF-8', 03:13:34 INFO - 'LANGUAGE': 'en_US:en', 03:13:34 INFO - 'LOGNAME': 'cltbld', 03:13:34 INFO - 'MAIL': '/var/mail/cltbld', 03:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:34 INFO - 'MOZ_NO_REMOTE': '1', 03:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:34 INFO - 'NO_EM_RESTART': '1', 03:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:34 INFO - 'PWD': '/builds/slave/test', 03:13:34 INFO - 'SHELL': '/bin/bash', 03:13:34 INFO - 'SHLVL': '1', 03:13:34 INFO - 'TERM': 'linux', 03:13:34 INFO - 'TMOUT': '86400', 03:13:34 INFO - 'USER': 'cltbld', 03:13:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:34 INFO - '_': '/tools/buildbot/bin/python'} 03:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:13:34 INFO - Cleaning up... 03:13:34 INFO - Return code: 0 03:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:13:34 INFO - Using env: {'DISPLAY': ':0', 03:13:34 INFO - 'HOME': '/home/cltbld', 03:13:34 INFO - 'LANG': 'en_US.UTF-8', 03:13:34 INFO - 'LANGUAGE': 'en_US:en', 03:13:34 INFO - 'LOGNAME': 'cltbld', 03:13:34 INFO - 'MAIL': '/var/mail/cltbld', 03:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:34 INFO - 'MOZ_NO_REMOTE': '1', 03:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:34 INFO - 'NO_EM_RESTART': '1', 03:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:34 INFO - 'PWD': '/builds/slave/test', 03:13:34 INFO - 'SHELL': '/bin/bash', 03:13:34 INFO - 'SHLVL': '1', 03:13:34 INFO - 'TERM': 'linux', 03:13:34 INFO - 'TMOUT': '86400', 03:13:34 INFO - 'USER': 'cltbld', 03:13:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:34 INFO - '_': '/tools/buildbot/bin/python'} 03:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:34 INFO - Cleaning up... 03:13:34 INFO - Return code: 0 03:13:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:34 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 0x7fc50bc46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a86350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:13:34 INFO - Using env: {'DISPLAY': ':0', 03:13:34 INFO - 'HOME': '/home/cltbld', 03:13:34 INFO - 'LANG': 'en_US.UTF-8', 03:13:34 INFO - 'LANGUAGE': 'en_US:en', 03:13:34 INFO - 'LOGNAME': 'cltbld', 03:13:34 INFO - 'MAIL': '/var/mail/cltbld', 03:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:34 INFO - 'MOZ_NO_REMOTE': '1', 03:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:34 INFO - 'NO_EM_RESTART': '1', 03:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:34 INFO - 'PWD': '/builds/slave/test', 03:13:34 INFO - 'SHELL': '/bin/bash', 03:13:34 INFO - 'SHLVL': '1', 03:13:34 INFO - 'TERM': 'linux', 03:13:34 INFO - 'TMOUT': '86400', 03:13:34 INFO - 'USER': 'cltbld', 03:13:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:34 INFO - '_': '/tools/buildbot/bin/python'} 03:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:35 INFO - Downloading/unpacking flake8 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:13:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:13:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:13:37 INFO - no previously-included directories found matching 'docs/_build' 03:13:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:13:37 INFO - Running setup.py install for pep8 03:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:13:37 INFO - no previously-included directories found matching 'docs/_build' 03:13:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:13:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:13:37 INFO - Cleaning up... 03:13:37 INFO - Return code: 0 03:13:37 INFO - Running post-action listener: _resource_record_post_action 03:13:37 INFO - Running post-action listener: _start_resource_monitoring 03:13:38 INFO - Starting resource monitoring. 03:13:38 INFO - ##### 03:13:38 INFO - ##### Finished create-virtualenv step (success) 03:13:38 INFO - ##### 03:13:38 INFO - ##### 03:13:38 INFO - ##### Running install step. 03:13:38 INFO - ##### 03:13:38 INFO - Running pre-action listener: _resource_record_pre_action 03:13:38 INFO - Running main action method: install 03:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:38 INFO - Reading from file tmpfile_stdout 03:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:38 INFO - Reading from file tmpfile_stdout 03:13:38 INFO - Output received: 03:13:38 INFO - Usage: mozinstall [options] installer 03:13:38 INFO - Options: 03:13:38 INFO - -h, --help show this help message and exit 03:13:38 INFO - -d DEST, --destination=DEST 03:13:38 INFO - Directory to install application into. [default: 03:13:38 INFO - "/builds/slave/test"] 03:13:38 INFO - --app=APP Application being installed. [default: firefox] 03:13:38 INFO - mkdir: /builds/slave/test/build/application 03:13:38 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'] 03:13:38 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 03:13:54 INFO - Reading from file tmpfile_stdout 03:13:54 INFO - Output received: 03:13:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:13:54 INFO - Running post-action listener: _resource_record_post_action 03:13:54 INFO - ##### 03:13:54 INFO - ##### Finished install step (success) 03:13:54 INFO - ##### 03:13:54 INFO - ##### 03:13:54 INFO - ##### Running run-tests step. 03:13:54 INFO - ##### 03:13:54 INFO - Running pre-action listener: _resource_record_pre_action 03:13:54 INFO - Running main action method: run_tests 03:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:54 INFO - Python 2.7.3 03:13:54 INFO - Return code: 0 03:13:54 INFO - grabbing minidump binary from tooltool 03:13: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')]} 03:13:54 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 0x1b151c0>, '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 0x1b160c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b16550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:13:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:13:54 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 03:13:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:54 INFO - Return code: 0 03:13:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:13:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:13:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:13:55 INFO - Return code: 0 03:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:13:55 INFO - Using env: {'DISPLAY': ':0', 03:13:55 INFO - 'HOME': '/home/cltbld', 03:13:55 INFO - 'LANG': 'en_US.UTF-8', 03:13:55 INFO - 'LANGUAGE': 'en_US:en', 03:13:55 INFO - 'LOGNAME': 'cltbld', 03:13:55 INFO - 'MAIL': '/var/mail/cltbld', 03:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:55 INFO - 'MOZ_NO_REMOTE': '1', 03:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:13:55 INFO - 'NO_EM_RESTART': '1', 03:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:55 INFO - 'PWD': '/builds/slave/test', 03:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:55 INFO - 'SHELL': '/bin/bash', 03:13:55 INFO - 'SHLVL': '1', 03:13:55 INFO - 'TERM': 'linux', 03:13:55 INFO - 'TMOUT': '86400', 03:13:55 INFO - 'USER': 'cltbld', 03:13:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786', 03:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:55 INFO - '_': '/tools/buildbot/bin/python'} 03:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:13:55 INFO - mozversion application_buildid: 20160622024801 03:13:55 INFO - mozversion application_changeset: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f 03:13:55 INFO - mozversion application_display_name: Nightly 03:13:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:55 INFO - mozversion application_name: Firefox 03:13:55 INFO - mozversion application_remotingname: firefox 03:13:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:13:55 INFO - mozversion application_vendor: Mozilla 03:13:55 INFO - mozversion application_version: 50.0a1 03:13:55 INFO - mozversion platform_buildid: 20160622024801 03:13:55 INFO - mozversion platform_changeset: ee2eba8cdedda9ec12caa8aa4903a525df1aaf2f 03:13:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:13:55 INFO - mozversion platform_version: 50.0a1 03:13:55 INFO - using testdate: 1466590435 03:13:55 INFO - actual date: 1466590435 03:13:55 INFO - starting webserver on 'localhost:50582' 03:13:55 INFO - SUITE-START | Running 2 tests 03:13:55 INFO - TEST-START | dromaeo_css 03:13:55 INFO - operating with platform_type : linux_ 03:13:55 INFO - Initialising browser for dromaeo_css test... 03:13:55 INFO - TEST-INFO | started process 3383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoOqXz/profile http://localhost:50582/getInfo.html) 03:14:04 INFO - PROCESS | 3383 | __metrics Screen width/height:1600/1200 03:14:04 INFO - PROCESS | 3383 | colorDepth:24 03:14:04 INFO - PROCESS | 3383 | Browser inner width/height: 1024/697 03:14:04 INFO - PROCESS | 3383 | __metrics 03:14:05 ERROR - PROCESS | 3383 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:14:06 INFO - TEST-INFO | 3383: exit 0 03:14:06 INFO - Browser initialized. 03:14:06 INFO - Running cycle 1/1 for dromaeo_css test... 03:14:06 INFO - TEST-INFO | started process 3500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoOqXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:18 INFO - PROCESS | 3500 | RSS: Main: 186339328 03:14:18 INFO - PROCESS | 3500 | 03:15:07 INFO - PROCESS | 3500 | 1466590507869 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:17:20 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50582/tests/dromaeo/cssquery-ext.html) 03:17:21 INFO - PROCESS | 3500 | RSS: Main: 189706240 03:17:21 INFO - PROCESS | 3500 | 03:20:23 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-ext.html (next: http://localhost:50582/tests/dromaeo/cssquery-jquery.html) 03:20:24 INFO - PROCESS | 3500 | RSS: Main: 188170240 03:20:24 INFO - PROCESS | 3500 | 03:23:25 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50582/tests/dromaeo/cssquery-mootools.html) 03:23:26 INFO - PROCESS | 3500 | RSS: Main: 189587456 03:23:26 INFO - PROCESS | 3500 | 03:26:28 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50582/tests/dromaeo/cssquery-prototype.html) 03:26:29 INFO - PROCESS | 3500 | RSS: Main: 187248640 03:26:29 INFO - PROCESS | 3500 | 03:29:31 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50582/tests/dromaeo/cssquery-yui.html) 03:29:32 INFO - PROCESS | 3500 | RSS: Main: 189255680 03:29:32 INFO - PROCESS | 3500 | 03:32:34 INFO - PROCESS | 3500 | Cycle 1(1): loaded http://localhost:50582/tests/dromaeo/cssquery-yui.html (next: http://localhost:50582/tests/dromaeo/cssquery-dojo.html) 03:32:35 INFO - PROCESS | 3500 | RSS: Main: 189964288 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | __start_tp_report 03:32:35 INFO - PROCESS | 3500 | _x_x_mozilla_page_load 03:32:35 INFO - PROCESS | 3500 | _x_x_mozilla_page_load_details 03:32:35 INFO - PROCESS | 3500 | |i|pagename|runs| 03:32:35 INFO - PROCESS | 3500 | |0;dojo.html;2643.5109504741617;2661.2548486423802;2678.5580379237426;2681.2760554650245;2695.231858920207;4736.644751643627;4750.667453278272;4758.214894542396;4816.8554943351755;4840.419149702041;4775.594074503671;4804.83183088592;4877.658563900528;4888.437829649592;4890.290907818364;4391.121775644876;4415.403920470743;4501.099780043988;4523.886902827423;4529.07154033424;4213.157368526292;4478.6417086633155;4497.033137875356;4563.612092972101;4576.039031803309;4388.561143885618;4450.087732014929;4451.799669014902;4464.933026004613;4524.524924882873;4439.911201775979;4492.730436173807;4502.099580083964;4523.932141017887;4567.406237189178;4430.800613972379;4449.421575195236;4454.5990860822685;4474.351219073216;4493.370928070073;4808.206645903421;4809.23052311632;4840.370751802243;4849.927251091236;4850.539198776146;5192.55863251624;5197.7920883164625;5199.376074871039;5213.139831927728;5227.947720522822;5034.3455350804525;5216.869578260574;5242.13504771716;5245.4754524547625;5261.0793111205385;4899.902001959941;4942.332785074041;4945.159322915113;4949.059678661043;4999.875003124951;5394.433584473652;5416.7562459688625;5418.051840927822;5432.91850622241;5459.454054594509;4990.426100998432;5026.321446604735;5060;5183.611229157828;5194.0650682876685;5046.192609182586;5134.948650513447;5153.510416510426;5154.5103215194495;5194.11700010999;5134.948650513522;5137.152369858932;5195.636305458582;5212.192110222922;5213.2701421800975;4958.057968985881;5066.03745288394;5175;5190.455002224788;5241.764120614582;4370.38814565961;4401.6698747594055;4421.911561768747;4446.177457170434;4446.866594002185;3818.5608655004476;3832.0611450194324;3848.807559622008;3853.056001279648;3856.9614303857165;4374.78126093694;4449.57729015743;4451.243288640874;4487.551244875486;4509.346144808985;5244.475552444801;5299.8410047698635;5304.522592966651;5317.229001794795;5334.06653835585;4530.343100250445;4531.365608814768;4539.205639013159;4553.7267763933605;4578.908421831545;4480.1711683338035;4604.907901841944;4645.0477652081245;4666.696664716783;4752.334673145693;4910.165271903857;4918.1393256180745;4920.975395123073;4941.2835138905375;4991.875203119951;5281.57747380201;5290.465764928128;5291.920621190762;5293.814716484904;5306.097963346163;4740.502247263988;4828.806847726051;4845.370101886732;4864.829730959399;4903.26451032348;5110.642255042111;5129.076766181974;5158.200478925773;5160.922586161136;5182.963407318627;5078.365204349457;5227;5229.372475302988;5233.084210263265;5237.031149237403;4913.729744864067;4936.975315123402;4949.183384741477;4953.752312384294;5013.949860501494;5019;5071.366079240095;5074.137396642506;5077.238414237746;5081;4970.801167953386;4993.80024799004;5001.374828146481;5015.64890457679;5044.9243261350375;4938.358013458227;5070.847874563769;5118.513741194581;5164.690118592896;5169.06956747789;4991.675541089818;5027.271045698426;5034.194528875362;5036.06832735945;5089.312942752829 03:32:35 INFO - PROCESS | 3500 | |1;ext.html;540.1902538201641;590.1148277583625;592.2478452365493;607.8601921558042;609.9113083146578;34583.654163458355;39000;39188;39231;39421.211575768466;38946.61053389465;39439.80280098603;39459;39560.208795824066;39746.8012659937;7574.469787114904;7679.57762323072;7684.308412242897;7727.72952946647;7740.380769538451;7687.308142267195;7789.260020298091;7828.373730101606;7833.451658383887;7840.411969102312;7706.7302644407455;7760.767176984699;7766.456348055638;7815.2966233039015;7820.061592608895;7704.152543220242;7708.38332933364;7734.458587898849;7742.729004484844;7768.262015108556;7613.0483689538805;7700.845983080307;7701.884471732872;7717.7298794542485;7752.418568607377;36847;36998.81500592507;37025;37264.44103338452;37394.25211495782;2590.4042070323744;2943.5290353543546;2975;3064.2798942248555;3098.1634958561062;27372.45255094907;27853.86073069642;28096.157115286573;28244.576331355045;28675.856620716764;3277.36091462165;3357.076803878953;3378.797272163678;3384.813835239061;3404.2510647657477;225580;225850;227221;227327;227786;31179.688203118134;31579.52630710541;31789.364212715616;31811.522827157612;31853.362932741216;31389.52915706266;31501;31526.684733152833;31582.842085789423;31653.20866978298;13592.38834252461;13603.115797473132;13619.114757540729;13717.657058573615;13794;11465.31208127515;11698.649040528799;11699.122565807598;11704.297742135499;11745.354005529778;7840.921590784019;7852.84294314122;7871.307668851225;7907.2488113629115;7927.920720792834;3088.6448058473115;3125.46867032605;3135.0751528299206;3179.5071763876635;3198.9200269993435;894.6287290774255;939.8167357365248;946.1910066892846;971.0144203633317;988.9703308900745;27304.180874573794;28513.714862851106;28622.713772862422;28752.913174988676;28831.71168288332;950.8716323296267;954.2413781044087;982.3712823792779;1037.8287582548946;1040.8646875906084;14973.925130374279;14981.775273370908;15051.247437628075;15082.773758393632;15309.234538273042;388433;388655;391675;394440;398283;48942.510574894506;49818.25272620914;50083.24875126876;50098.24852627214;50158.247626285636;1157.2593540134321;1203.7231436769591;1204.6687161030611;1209.9879001210052;1222.4132416440336;26752.59871101896;27245.182644520697;27783.824807022003;28461.146165615064;28517.42965140727;42295.5770442304;42498;42874;42962.78518607387;42982;260869;260905;260960;261348;262411;24974;25029.49941001206;25191.11831085903;25419.491610167323;25432;41693.166136677704;42139;42506;42815;43388.132237355705;35947.640523594426;36173;36323.091922702144;36556.26887462289;36940.6305936948;35772;36053.81973090118;36457;36496;36950.81524592467;35317.82341088278;35446.645533545365;35633;36266;36469.08827279339;31682.366352673278;32546.837265814465;33030.33939321152;33076.83461582677;33159.33681326408;24460.6330905033;25130.37174070663;25529.23412297634;25533.9786408549;25634.743652563237 03:32:35 INFO - PROCESS | 3500 | |2;jquery.html;370.94250391189365;371.17228580266004;371.51146242690874;387.4111350746867;396.0613346369104;16205.513834584966;16527.338906443743;17095.14524273786;17171;18159.45521634353;17530.64938701225;18625.906870465627;18651;18922.810771892277;19625.509362265915;5598.720063996804;5820.38885916979;5878.50032747217;5887;5907.497862681677;5216.6869987800665;7051.47113966452;7065.116860392451;7156.391706704936;7201.027861238745;7099.787006389816;7171.928280717204;7184.317489838483;7233.710651573931;7258.3104605062435;6771.661416929159;6886.931130688679;6953.408960238386;6969.05917701109;6988.126484189476;6631.86736265272;6798.966005169992;6810.421114205249;6851.314868513158;6864.347886950732;20384.796152038438;22701.97841097138;22748.88625556878;23424.531509369717;23476.413089672726;1955.1104247567323;2003.388966365258;2077.657186564215;2169.1540299283292;2387.331547166796;13725.588232353046;14017;14110.223937683424;14765.77851332231;14967.101973881601;1795.5511122219445;1827.6566723458247;1836.8163183681659;1866.925322987079;1937.0508450859118;78023.92844465091;82826;83160.58419707924;83217.58391208066;84270.57864710699;16163.43427980015;16885.83114168867;17291.39480118215;17451.73822392665;17665;28575.14274571766;28588.571171432446;29487.852560737058;29506;29536.113916582537;8957.14907083839;9042;9145.176934075966;9434.905650943403;9459.574319155654;7252.202257751643;7362.963185184147;7441.776746697607;7496.362809161283;7523.435742319239;3527.6472352764517;3862.362710152793;8312.501249925024;8398.664053437917;8507.276881465144;1842.870999030055;1873.4660621722744;1877.474307193988;1894.1381671339507;1927.5015846239312;828.5939889454124;856.002756788347;861.2894362151251;881.6076845803684;922.6770630279483;16422;16599.751003734953;16639.916800415922;16963.491095267163;17385.913070434566;819.6844214977276;857.3012994409661;888.560162719458;895.8778656382502;941.4398432932394;9111.81776364469;9422.717318480456;9431.905680943102;9437.103475169848;9625.903740962502;367620;371824;375175;376627;381982;45700.54299457029;46434.303485447745;46525.30212046822;47832.76083619629;48003.27995080077;851.2764150472173;875.9562021899008;881.8148188880278;896.4710820615868;899.59967814322;14876.586724261178;15093.396264149751;15107.622309442351;15157.242137893281;15558.766618500506;24825.376481896543;26363.077292294678;35538.46692299669;36215.042651815165;37002.814985924895;47209.52790472051;48121.518784811706;49043.50956490389;49416;49573.75213124056;6358.205224346957;6571.80284591463;6779.322067793379;6919.6886140124825;6981.5112942093565;11007;12354.135210535176;12364.876351236373;12583.87416125827;12756.808647870104;10205.336653117523;10358.378497290187;10454.11140053104;10513.474326283502;10516.68449946503;10592.735181620521;10777.62278320255;10793.514291856729;10929.234953553492;10950.233483656068;9834;9991.400515969066;10602.89397106019;10767.114717142413;10791;7682.577458239851;7838.608069596611;8028.718994835152;8101.635426405708;8108.067572229269;7946.165652606393;9048.502332371783;10001.74995625086;10064.144547713233;10538.57845686164 03:32:35 INFO - PROCESS | 3500 | |3;mootools.html;1350.223621417685;1384.1349156777014;1460.7297649934762;1652.0748380906693;1659.8589119924807;6859.657017149148;7411.258874112586;7562.848743025136;8069.152738962405;8075;7573.659185336659;7701.152873183959;7759.41804364672;7819.530828150315;7867.291943725064;2167.122315462236;2232.2968264996475;2251.718535183102;2256.041182497432;2261.4798596322858;2174.5650869826018;2188.4310079379316;2234.6089434349005;2238.1271304191378;2246.4608493961496;2228.1644383356243;2248.6739422783685;2249.280230326296;2252.4706693926914;2271.772822717723;2203.6914831923464;2204.713387259662;2211.303439416579;2218.900149493277;2219.94450138747;2189.9343019709436;2194.9451263718533;2200.1639377036786;2222.5665995130958;2223.444138965259;7757.301842834116;7899.289063984269;7900.960495197544;7905.604719764046;7916.445848790587;4584.770761461947;4661.696989695659;4698.365720627706;4699.459562150328;4702.694324868872;2991.536311871642;3021.7884748067645;3124.6719094495206;3156.71589556941;3168.8415579220946;984.306064224727;992.3153024413205;992.3995982430598;1011.6762635956497;1023.9436830974294;10699.625513107081;10967.177461690326;10999.670009899715;11014.229003969725;11016;4188.827128403991;4220.767857767791;4250.57605702087;4379.715318504287;4385.890352741207;9377.906220937839;9435.622575097057;9447.196988255937;9461.952690236643;9486.33595648298;4740.146773580788;4747.976260118678;4748.548887855648;4754.334393184957;4755.762211889391;3751.8499260029294;4162.709560036398;4169.499660040815;4298.26929421999;4309.827606895752;3668.853245870135;3715.275521273326;3767.3972164453558;3798.088458769875;3910.8631197907935;1174.7650469906052;1222.3949145173196;1223.7919553675897;1226.8221107939298;1236.7526494700917;766.9156392796788;864.4597126795753;890.9376343655882;892.9642814287486;904.4482865452069;5456.372517160498;5464.9180262296095;5596.860078497989;5625.184348269478;5738.368779434259;403.6710081283744;410.8438793258543;414.2708832454841;417.74308800087726;422.6365325819792;3828.9617103829164;3832.5017747692623;3901.1027463683513;3938.1532970410926;3983.342748446532;9549.761255968657;9782.51087445625;9827.4103553787;9874.506274686237;9890.258230632731;9636.277279203947;9675.177609903096;9730.61077556904;9793.363431376938;9861.852072218779;7231.493795434374;7277.163126240444;7292.854142917112;7315.158756742936;7344;5465.7813687453645;5489.752961116679;5490.845267063015;5519.3652729936575;5596.664200148004;9029.41308814925;9098;9194.632214711337;9209.677661281823;9235.353525253167;8986.551656929862;9136.26909847224;9278.489683067226;9288.72133835986;9288.860667090134;6125.663088530174;6770.1537307836525;6834.760783372558;6896.413804826646;6906.447484201352;7594.8860767087435;7650.732224372343;7655.0813902332075;7661.770146895602;7695.23047695226;6671.966640166962;6784.185897692309;6843.863122737418;6874.175098988154;7005.859882802213;6831.2144103428745;6857.5199736018;6869.381755641816;6900.30996900326;6997.055397521473;5876.853078673067;5878.147668588116;5896.056630939029;5935.34711181761;6091.756329746938;4356.477222733292;4363.738175709467;4378.277584198571;4433.113377324484;4460.018795864905;4649.093426781745;4666.2767271073035;4666.510016448224;4697.1545121877025;4716.551927566876 03:32:35 INFO - PROCESS | 3500 | |4;prototype.html;293.8927291538589;309.622260841773;313.8101448623582;316.225248142052;316.74976768353;4928.5564299213065;5018.523240292176;5055.772490237939;5161.406438259602;5211.713355765436;5057.342545469084;5105.489451054902;5111.361079865017;5115.693058416488;5134.922976155361;3972.781497017663;3999.7400168988925;4016.979915100435;4027.234825383168;4057.6550993165615;3977.3835055566433;3977.443157957888;3983.3228351180223;4021.2158629067344;4059.7361171523903;3954.8841369867127;3965.2267807777494;3974.4435778990965;3974.8075577326686;3987.162695833864;3959;3994.580569040267;4000.719949603529;4013.257547353749;4038.3336749436307;3540.132667496454;3572.8749493767855;3574.6782789548806;3581.6776490116013;3582.6417358264225;4758.643101767347;4992.276119962585;4992.301077849104;5003.524665156804;5068.5691716204165;4581.106684196583;4618.745968971705;4619.3438772705495;4622.699524530894;4633.235516139833;5385.7307134643115;5391.137418013099;5397.676139431646;5402.567794576464;5408.945910540883;3784.7539909906045;3842.654161125512;3868.2650296443867;3869.825857836376;3913.3151698452943;5595.964746521907;5611.887762244733;5619.6066275360745;5658.179563963244;5666.206731057655;3977.164795393;3981.163955569305;3997.760134391946;4002.6597739192493;4002.899927501836;3700.50043244164;3942.6792024672054;4050.513938327361;4075.735077219971;4076.9388459173138;4460.34967062189;4486.743711760712;4493.146302202636;4494.4157259556705;4515.864524064284;5282.0456431119965;5296.417394086648;5301.973490132602;5304.575633949352;5304.9734751326;1260.1682889293022;1304.1327517201146;1346.3201083452793;1348.2854087333728;1356.165957935882;835.4653022065883;851.9105493923173;854.7264875239864;863.9006514250941;872.5113936195623;4175.770332631734;4183.937240941388;4235.512916014636;4256.127493863751;4263.25206665272;4868.586170175504;4874.806337148298;4894.951050489521;4897.951020489821;4900.990593856502;4156.937645935313;4202.285611446062;4206.200821843901;4215.156968606291;4221.303484925014;2514.911978080758;2591.1708253358743;2613.2944105091897;2619.8428094314404;2620.6986196587254;4525.389072475239;4552.93006143556;4557.635389168859;4581.633469322513;4627.5603817637275;4927.4768540493715;4964.776585053609;4971.527704868032;5050.090983622909;5069.290299358093;4334.956650433455;4620.5148459411275;4637.6289896808175;4643.535646435397;4645.374119058302;4927.162382395073;4947.282644016669;4950.430700469492;4965.925511117264;4970.353853999101;4689.320048593003;4748.264019077049;4765.904681906273;4776.713397196179;4780;4332.783360831882;4560.6807523473035;4575.794089266057;4588.816447342069;4590.403247577793;3511.139096278976;3515.472679098156;3529.470579413006;3532.805695686659;3569.518115054538;4915.287283343823;4924.458309585871;4931.432885218246;4940.270905183157;5287.625217443569;5219.373675159005;5263.842084737464;5336.67979921206;5374.3013408256675;5391.598184471987;5271.182966640177;5321.281626980308;5324.680519168863;5336.386315573759;5362.785488580413;5191.092987926773;5198.558122559625;5203.543007957778;5240;5242.318498595311;5286.471352864683;5327.813526526553;5333.280007199133;5384.784608615611;5386.596005299697;5217.2434996925995;5263.421023687468;5308.4160742317545;5310.2831117798605;5330.920036199538 03:32:35 INFO - PROCESS | 3500 | |5;yui.html;623.2334228898455;671.506442764568;689.6379400814568;704.4892452971594;726.9967444926001;11949.522019119237;12209.26744395337;12614.936925315373;12790.168639038457;13274.933625331883;13204.207747535154;13232.404541795619;13245.13906596073;13252;13270.867291327084;619.5910698938701;769.8075481129717;788.2866006264326;797.8523973064972;808.9474184178009;785.4344871692401;790.7074382478492;791.7110254757001;792.742358733411;797.1390897830329;836.564986207172;837.815680550278;839.3872473094644;839.890814194157;840.8276303357827;833.4624167412046;833.9207775261341;836.7406104107715;839.1901814748766;840.1136800675285;608.9117078023662;610.9541784366146;611.9571629985903;613.3743581546842;615.7536985205909;12344.938275308656;12350.44423000967;12370.81443778344;12394;12400.81398779019;13299;13640.40121762567;13905.86094139066;14136.081154725012;14211.50259740904;10489.213309001856;10496.265261431703;10528.210384221215;10569.630062947837;10629.73425664357;3374.9156271093175;3397.3205358928067;3403.4894765785084;3416.7437442191936;3485.2158264390564;62127.689361552904;62584.687076564325;62607;62865.68567157181;62970.37029629691;9948;10477.68566942993;10737.624183153708;10751.139908807432;10871.891281087088;18157.636847263246;18200.817991819913;18247.908760456114;18282.817171828112;18330.725039124423;6878.484113691393;6882.827929301808;6935.6878940447805;7049.859002819915;7101.680424380916;3685.760425572329;3723.9627603724157;3751.756135851161;3776.9433458498142;3794.658480736747;2824.0680575410065;2878.136559032282;2898.9130326090253;2903;2906.462304473679;517.5549027836058;520.8801975545646;521.0932976620728;529.7907326606046;530.2920600997711;487.8731529802277;553.347050480429;570.8173384516915;575.3498546642351;580.0124146492861;7739.264769846855;7985.843822167982;8059.919400805917;8066.717664881701;8106.675732970615;450.8512190977035;510.84163909187527;514.143950322716;550.2928736573564;580.3442110415289;3602.7838329699775;3631.7358449455555;3667.633236676311;3670.284294562588;3807.3908174691915;90810.54594726984;92164.53917730368;92580.53709731543;94188.52905735564;94835;81157;81798.59100704458;83428;84011.5799420999;84291.5785421069;58655.70672146697;70992.64503677552;74781.62609187028;75384.62307688427;75433;7002.299770023161;7127.429805615642;7193.604351760494;7217.747378841926;7289.927100728924;37975.810120949216;42664.78667606642;44108;44282.77858610686;45772.7711361441;61048.084278736744;65196;65802.67098664476;65840.34159658341;65940.67029664821;9802.705918822447;9910.35582687123;10090.09189172978;10114.494275286059;10131.949340253252;10401.53193106297;10449.634262800766;10613;10624.468776561296;10713.892861071601;10151.238657100896;10250.58997640086;10255.179585632983;10264.127549158107;10462.110720588835;9629;9781.657641982496;9800.754981125529;9909.504524773589;10079.848802268118;9718.562664680248;9769;9878.950605247215;9903.45530995802;9955.104040636088;8331.875021874797;8686.348523860863;8793.692220772242;8891.4665120093;8897.73306800797;7808.57052862098;8018.639161237875;8194.631241594023;8250.669973201006;8554.657813687383 03:32:35 INFO - PROCESS | 3500 | __end_tp_report 03:32:35 INFO - PROCESS | 3500 | __start_cc_report 03:32:35 INFO - PROCESS | 3500 | _x_x_mozilla_cycle_collect,388 03:32:35 INFO - PROCESS | 3500 | __end_cc_report 03:32:35 INFO - PROCESS | 3500 | __startTimestamp1466591555218__endTimestamp 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | ------- Summary: start ------- 03:32:35 INFO - PROCESS | 3500 | Number of tests: 6 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#0] dojo.html Cycles:165 Average:4804.79 Median:4941.28 stddev:514.83 (10.4%) stddev-sans-first:487.70 03:32:35 INFO - PROCESS | 3500 | Values: 2643.5 2661.3 2678.6 2681.3 2695.2 4736.6 4750.7 4758.2 4816.9 4840.4 4775.6 4804.8 4877.7 4888.4 4890.3 4391.1 4415.4 4501.1 4523.9 4529.1 4213.2 4478.6 4497.0 4563.6 4576.0 4388.6 4450.1 4451.8 4464.9 4524.5 4439.9 4492.7 4502.1 4523.9 4567.4 4430.8 4449.4 4454.6 4474.4 4493.4 4808.2 4809.2 4840.4 4849.9 4850.5 5192.6 5197.8 5199.4 5213.1 5227.9 5034.3 5216.9 5242.1 5245.5 5261.1 4899.9 4942.3 4945.2 4949.1 4999.9 5394.4 5416.8 5418.1 5432.9 5459.5 4990.4 5026.3 5060.0 5183.6 5194.1 5046.2 5134.9 5153.5 5154.5 5194.1 5134.9 5137.2 5195.6 5212.2 5213.3 4958.1 5066.0 5175.0 5190.5 5241.8 4370.4 4401.7 4421.9 4446.2 4446.9 3818.6 3832.1 3848.8 3853.1 3857.0 4374.8 4449.6 4451.2 4487.6 4509.3 5244.5 5299.8 5304.5 5317.2 5334.1 4530.3 4531.4 4539.2 4553.7 4578.9 4480.2 4604.9 4645.0 4666.7 4752.3 4910.2 4918.1 4921.0 4941.3 4991.9 5281.6 5290.5 5291.9 5293.8 5306.1 4740.5 4828.8 4845.4 4864.8 4903.3 5110.6 5129.1 5158.2 5160.9 5183.0 5078.4 5227.0 5229.4 5233.1 5237.0 4913.7 4937.0 4949.2 4953.8 5013.9 5019.0 5071.4 5074.1 5077.2 5081.0 4970.8 4993.8 5001.4 5015.6 5044.9 4938.4 5070.8 5118.5 5164.7 5169.1 4991.7 5027.3 5034.2 5036.1 5089.3 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#1] ext.html Cycles:180 Average:43596.19 Median:35702.50 stddev:79677.51 (223.2%) stddev-sans-first:79835.45 03:32:35 INFO - PROCESS | 3500 | Values: 540.2 590.1 592.2 607.9 609.9 34583.7 39000.0 39188.0 39231.0 39421.2 38946.6 39439.8 39459.0 39560.2 39746.8 7574.5 7679.6 7684.3 7727.7 7740.4 7687.3 7789.3 7828.4 7833.5 7840.4 7706.7 7760.8 7766.5 7815.3 7820.1 7704.2 7708.4 7734.5 7742.7 7768.3 7613.0 7700.8 7701.9 7717.7 7752.4 36847.0 36998.8 37025.0 37264.4 37394.3 2590.4 2943.5 2975.0 3064.3 3098.2 27372.5 27853.9 28096.2 28244.6 28675.9 3277.4 3357.1 3378.8 3384.8 3404.3 225580.0 225850.0 227221.0 227327.0 227786.0 31179.7 31579.5 31789.4 31811.5 31853.4 31389.5 31501.0 31526.7 31582.8 31653.2 13592.4 13603.1 13619.1 13717.7 13794.0 11465.3 11698.6 11699.1 11704.3 11745.4 7840.9 7852.8 7871.3 7907.2 7927.9 3088.6 3125.5 3135.1 3179.5 3198.9 894.6 939.8 946.2 971.0 989.0 27304.2 28513.7 28622.7 28752.9 28831.7 950.9 954.2 982.4 1037.8 1040.9 14973.9 14981.8 15051.2 15082.8 15309.2 388433.0 388655.0 391675.0 394440.0 398283.0 48942.5 49818.3 50083.2 50098.2 50158.2 1157.3 1203.7 1204.7 1210.0 1222.4 26752.6 27245.2 27783.8 28461.1 28517.4 42295.6 42498.0 42874.0 42962.8 42982.0 260869.0 260905.0 260960.0 261348.0 262411.0 24974.0 25029.5 25191.1 25419.5 25432.0 41693.2 42139.0 42506.0 42815.0 43388.1 35947.6 36173.0 36323.1 36556.3 36940.6 35772.0 36053.8 36457.0 36496.0 36950.8 35317.8 35446.6 35633.0 36266.0 36469.1 31682.4 32546.8 33030.3 33076.8 33159.3 24460.6 25130.4 25529.2 25534.0 25634.7 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#2] jquery.html Cycles:180 Average:24393.20 Median:2124.89 stddev:61537.02 (2896.0%) stddev-sans-first:61683.22 03:32:35 INFO - PROCESS | 3500 | Values: 370.9 371.2 371.5 387.4 396.1 16205.5 16527.3 17095.1 17171.0 18159.5 17530.6 18625.9 18651.0 18922.8 19625.5 5598.7 5820.4 5878.5 5887.0 5907.5 5216.7 7051.5 7065.1 7156.4 7201.0 7099.8 7171.9 7184.3 7233.7 7258.3 6771.7 6886.9 6953.4 6969.1 6988.1 6631.9 6799.0 6810.4 6851.3 6864.3 20384.8 22702.0 22748.9 23424.5 23476.4 1955.1 2003.4 2077.7 2169.2 2387.3 13725.6 14017.0 14110.2 14765.8 14967.1 1795.6 1827.7 1836.8 1866.9 1937.1 78023.9 82826.0 83160.6 83217.6 84270.6 16163.4 16885.8 17291.4 17451.7 17665.0 28575.1 28588.6 29487.9 29506.0 29536.1 8957.1 9042.0 9145.2 9434.9 9459.6 7252.2 7363.0 7441.8 7496.4 7523.4 3527.6 3862.4 8312.5 8398.7 8507.3 1842.9 1873.5 1877.5 1894.1 1927.5 828.6 856.0 861.3 881.6 922.7 16422.0 16599.8 16639.9 16963.5 17385.9 819.7 857.3 888.6 895.9 941.4 9111.8 9422.7 9431.9 9437.1 9625.9 367620.0 371824.0 375175.0 376627.0 381982.0 45700.5 46434.3 46525.3 47832.8 48003.3 851.3 876.0 881.8 896.5 899.6 14876.6 15093.4 15107.6 15157.2 15558.8 24825.4 26363.1 35538.5 36215.0 37002.8 47209.5 48121.5 49043.5 49416.0 49573.8 6358.2 6571.8 6779.3 6919.7 6981.5 11007.0 12354.1 12364.9 12583.9 12756.8 10205.3 10358.4 10454.1 10513.5 10516.7 10592.7 10777.6 10793.5 10929.2 10950.2 9834.0 9991.4 10602.9 10767.1 10791.0 7682.6 7838.6 8028.7 8101.6 8108.1 7946.2 9048.5 10001.7 10064.1 10538.6 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#3] mootools.html Cycles:180 Average:5213.02 Median:4755.05 stddev:2931.77 (61.7%) stddev-sans-first:2925.62 03:32:35 INFO - PROCESS | 3500 | Values: 1350.2 1384.1 1460.7 1652.1 1659.9 6859.7 7411.3 7562.8 8069.2 8075.0 7573.7 7701.2 7759.4 7819.5 7867.3 2167.1 2232.3 2251.7 2256.0 2261.5 2174.6 2188.4 2234.6 2238.1 2246.5 2228.2 2248.7 2249.3 2252.5 2271.8 2203.7 2204.7 2211.3 2218.9 2219.9 2189.9 2194.9 2200.2 2222.6 2223.4 7757.3 7899.3 7901.0 7905.6 7916.4 4584.8 4661.7 4698.4 4699.5 4702.7 2991.5 3021.8 3124.7 3156.7 3168.8 984.3 992.3 992.4 1011.7 1023.9 10699.6 10967.2 10999.7 11014.2 11016.0 4188.8 4220.8 4250.6 4379.7 4385.9 9377.9 9435.6 9447.2 9462.0 9486.3 4740.1 4748.0 4748.5 4754.3 4755.8 3751.8 4162.7 4169.5 4298.3 4309.8 3668.9 3715.3 3767.4 3798.1 3910.9 1174.8 1222.4 1223.8 1226.8 1236.8 766.9 864.5 890.9 893.0 904.4 5456.4 5464.9 5596.9 5625.2 5738.4 403.7 410.8 414.3 417.7 422.6 3829.0 3832.5 3901.1 3938.2 3983.3 9549.8 9782.5 9827.4 9874.5 9890.3 9636.3 9675.2 9730.6 9793.4 9861.9 7231.5 7277.2 7292.9 7315.2 7344.0 5465.8 5489.8 5490.8 5519.4 5596.7 9029.4 9098.0 9194.6 9209.7 9235.4 8986.6 9136.3 9278.5 9288.7 9288.9 6125.7 6770.2 6834.8 6896.4 6906.4 7594.9 7650.7 7655.1 7661.8 7695.2 6672.0 6784.2 6843.9 6874.2 7005.9 6831.2 6857.5 6869.4 6900.3 6997.1 5876.9 5878.1 5896.1 5935.3 6091.8 4356.5 4363.7 4378.3 4433.1 4460.0 4649.1 4666.3 4666.5 4697.2 4716.6 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#4] prototype.html Cycles:180 Average:4270.48 Median:4630.40 stddev:1233.58 (26.6%) stddev-sans-first:1200.39 03:32:35 INFO - PROCESS | 3500 | Values: 293.9 309.6 313.8 316.2 316.7 4928.6 5018.5 5055.8 5161.4 5211.7 5057.3 5105.5 5111.4 5115.7 5134.9 3972.8 3999.7 4017.0 4027.2 4057.7 3977.4 3977.4 3983.3 4021.2 4059.7 3954.9 3965.2 3974.4 3974.8 3987.2 3959.0 3994.6 4000.7 4013.3 4038.3 3540.1 3572.9 3574.7 3581.7 3582.6 4758.6 4992.3 4992.3 5003.5 5068.6 4581.1 4618.7 4619.3 4622.7 4633.2 5385.7 5391.1 5397.7 5402.6 5408.9 3784.8 3842.7 3868.3 3869.8 3913.3 5596.0 5611.9 5619.6 5658.2 5666.2 3977.2 3981.2 3997.8 4002.7 4002.9 3700.5 3942.7 4050.5 4075.7 4076.9 4460.3 4486.7 4493.1 4494.4 4515.9 5282.0 5296.4 5302.0 5304.6 5305.0 1260.2 1304.1 1346.3 1348.3 1356.2 835.5 851.9 854.7 863.9 872.5 4175.8 4183.9 4235.5 4256.1 4263.3 4868.6 4874.8 4895.0 4898.0 4901.0 4156.9 4202.3 4206.2 4215.2 4221.3 2514.9 2591.2 2613.3 2619.8 2620.7 4525.4 4552.9 4557.6 4581.6 4627.6 4927.5 4964.8 4971.5 5050.1 5069.3 4335.0 4620.5 4637.6 4643.5 4645.4 4927.2 4947.3 4950.4 4965.9 4970.4 4689.3 4748.3 4765.9 4776.7 4780.0 4332.8 4560.7 4575.8 4588.8 4590.4 3511.1 3515.5 3529.5 3532.8 3569.5 4915.3 4924.5 4931.4 4940.3 5287.6 5219.4 5263.8 5336.7 5374.3 5391.6 5271.2 5321.3 5324.7 5336.4 5362.8 5191.1 5198.6 5203.5 5240.0 5242.3 5286.5 5327.8 5333.3 5384.8 5386.6 5217.2 5263.4 5308.4 5310.3 5330.9 03:32:35 INFO - PROCESS | 3500 | 03:32:35 INFO - PROCESS | 3500 | [#5] yui.html Cycles:180 Average:17166.87 Median:30829.52 stddev:24830.43 (80.5%) stddev-sans-first:24869.02 03:32:35 INFO - PROCESS | 3500 | Values: 623.2 671.5 689.6 704.5 727.0 11949.5 12209.3 12614.9 12790.2 13274.9 13204.2 13232.4 13245.1 13252.0 13270.9 619.6 769.8 788.3 797.9 808.9 785.4 790.7 791.7 792.7 797.1 836.6 837.8 839.4 839.9 840.8 833.5 833.9 836.7 839.2 840.1 608.9 611.0 612.0 613.4 615.8 12344.9 12350.4 12370.8 12394.0 12400.8 13299.0 13640.4 13905.9 14136.1 14211.5 10489.2 10496.3 10528.2 10569.6 10629.7 3374.9 3397.3 3403.5 3416.7 3485.2 62127.7 62584.7 62607.0 62865.7 62970.4 9948.0 10477.7 10737.6 10751.1 10871.9 18157.6 18200.8 18247.9 18282.8 18330.7 6878.5 6882.8 6935.7 7049.9 7101.7 3685.8 3724.0 3751.8 3776.9 3794.7 2824.1 2878.1 2898.9 2903.0 2906.5 517.6 520.9 521.1 529.8 530.3 487.9 553.3 570.8 575.3 580.0 7739.3 7985.8 8059.9 8066.7 8106.7 450.9 510.8 514.1 550.3 580.3 3602.8 3631.7 3667.6 3670.3 3807.4 90810.5 92164.5 92580.5 94188.5 94835.0 81157.0 81798.6 83428.0 84011.6 84291.6 58655.7 70992.6 74781.6 75384.6 75433.0 7002.3 7127.4 7193.6 7217.7 7289.9 37975.8 42664.8 44108.0 44282.8 45772.8 61048.1 65196.0 65802.7 65840.3 65940.7 9802.7 9910.4 10090.1 10114.5 10131.9 10401.5 10449.6 10613.0 10624.5 10713.9 10151.2 10250.6 10255.2 10264.1 10462.1 9629.0 9781.7 9800.8 9909.5 10079.8 9718.6 9769.0 9879.0 9903.5 9955.1 8331.9 8686.3 8793.7 8891.5 8897.7 7808.6 8018.6 8194.6 8250.7 8554.7 03:32:35 INFO - PROCESS | 3500 | -------- Summary: end -------- 03:32:35 INFO - PROCESS | 3500 | 03:32:36 INFO - TEST-INFO | 3500: exit 0 03:32:36 INFO - TEST-OK | dromaeo_css | took 1120289ms 03:32:36 INFO - TEST-START | kraken 03:32:36 INFO - operating with platform_type : linux_ 03:32:36 INFO - Initialising browser for kraken test... 03:32:36 INFO - TEST-INFO | started process 3736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbnzY3M/profile http://localhost:50582/getInfo.html) 03:32:41 INFO - PROCESS | 3736 | __metrics Screen width/height:1600/1200 03:32:41 INFO - PROCESS | 3736 | colorDepth:24 03:32:41 INFO - PROCESS | 3736 | Browser inner width/height: 1024/697 03:32:41 INFO - PROCESS | 3736 | __metrics 03:32:41 ERROR - PROCESS | 3736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:32:42 INFO - TEST-INFO | 3736: exit 0 03:32:42 INFO - Browser initialized. 03:32:42 INFO - Running cycle 1/1 for kraken test... 03:32:42 INFO - TEST-INFO | started process 3854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbnzY3M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:54 INFO - PROCESS | 3854 | RSS: Main: 186146816 03:32:54 INFO - PROCESS | 3854 | 03:32:57 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50582/tests/kraken/driver.html?testName=audio-beat-detection) 03:32:58 INFO - PROCESS | 3854 | RSS: Main: 190631936 03:32:58 INFO - PROCESS | 3854 | 03:33:01 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50582/tests/kraken/driver.html?testName=audio-dft) 03:33:01 INFO - PROCESS | 3854 | RSS: Main: 190205952 03:33:01 INFO - PROCESS | 3854 | 03:33:04 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50582/tests/kraken/driver.html?testName=audio-fft) 03:33:05 INFO - PROCESS | 3854 | RSS: Main: 186355712 03:33:05 INFO - PROCESS | 3854 | 03:33:07 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50582/tests/kraken/driver.html?testName=audio-oscillator) 03:33:08 INFO - PROCESS | 3854 | RSS: Main: 186441728 03:33:08 INFO - PROCESS | 3854 | 03:33:10 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50582/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:33:11 INFO - PROCESS | 3854 | RSS: Main: 187068416 03:33:11 INFO - PROCESS | 3854 | 03:33:14 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50582/tests/kraken/driver.html?testName=imaging-darkroom) 03:33:15 INFO - PROCESS | 3854 | RSS: Main: 187600896 03:33:15 INFO - PROCESS | 3854 | 03:33:18 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50582/tests/kraken/driver.html?testName=imaging-desaturate) 03:33:19 INFO - PROCESS | 3854 | RSS: Main: 184803328 03:33:19 INFO - PROCESS | 3854 | 03:33:22 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50582/tests/kraken/driver.html?testName=json-parse-financial) 03:33:22 INFO - PROCESS | 3854 | RSS: Main: 185749504 03:33:22 INFO - PROCESS | 3854 | 03:33:24 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50582/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:33:25 INFO - PROCESS | 3854 | RSS: Main: 186789888 03:33:25 INFO - PROCESS | 3854 | 03:33:26 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:33:27 INFO - PROCESS | 3854 | RSS: Main: 186961920 03:33:27 INFO - PROCESS | 3854 | 03:33:29 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:30 INFO - PROCESS | 3854 | RSS: Main: 187625472 03:33:30 INFO - PROCESS | 3854 | 03:33:33 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:33 INFO - PROCESS | 3854 | RSS: Main: 187469824 03:33:33 INFO - PROCESS | 3854 | 03:33:36 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:33:37 INFO - PROCESS | 3854 | RSS: Main: 186933248 03:33:37 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | Cycle 1(1): loaded http://localhost:50582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50582/tests/kraken/driver.html?testName=ai-astar) 03:33:39 INFO - PROCESS | 3854 | RSS: Main: 188325888 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | __start_tp_report 03:33:39 INFO - PROCESS | 3854 | _x_x_mozilla_page_load 03:33:39 INFO - PROCESS | 3854 | _x_x_mozilla_page_load_details 03:33:39 INFO - PROCESS | 3854 | |i|pagename|runs| 03:33:39 INFO - PROCESS | 3854 | |0;ai-astar;114;108;113;114;113;114;115;114;112;112 03:33:39 INFO - PROCESS | 3854 | |1;audio-beat-detection;159;139;162;190;132;157;164;139;195;138 03:33:39 INFO - PROCESS | 3854 | |2;audio-dft;163;172;167;161;161;163;161;164;164;162 03:33:39 INFO - PROCESS | 3854 | |3;audio-fft;77;78;76;160;80;78;75;75;172;77 03:33:39 INFO - PROCESS | 3854 | |4;audio-oscillator;88;87;148;88;87;87;136;86;86;144 03:33:39 INFO - PROCESS | 3854 | |5;imaging-gaussian-blur;118;118;118;117;118;119;118;119;117;119 03:33:39 INFO - PROCESS | 3854 | |6;imaging-darkroom;149;148;149;148;149;149;148;147;148;147 03:33:39 INFO - PROCESS | 3854 | |7;imaging-desaturate;96;96;97;97;96;96;95;97;96;96 03:33:39 INFO - PROCESS | 3854 | |8;json-parse-financial;65;63;63;70;63;65;66;64;65;64 03:33:39 INFO - PROCESS | 3854 | |9;json-stringify-tinderbox;65;64;67;66;65;66;64;65;66;65 03:33:39 INFO - PROCESS | 3854 | |10;stanford-crypto-aes;91;82;83;84;90;84;85;84;106;86 03:33:39 INFO - PROCESS | 3854 | |11;stanford-crypto-ccm;142;134;130;138;131;136;149;132;138;154 03:33:39 INFO - PROCESS | 3854 | |12;stanford-crypto-pbkdf2;173;175;172;175;172;166;174;172;176;169 03:33:39 INFO - PROCESS | 3854 | |13;stanford-crypto-sha256-iterative;67;69;69;70;69;70;67;67;66;67 03:33:39 INFO - PROCESS | 3854 | __end_tp_report 03:33:39 INFO - PROCESS | 3854 | __start_cc_report 03:33:39 INFO - PROCESS | 3854 | _x_x_mozilla_cycle_collect,940 03:33:39 INFO - PROCESS | 3854 | __end_cc_report 03:33:39 INFO - PROCESS | 3854 | __startTimestamp1466591619549__endTimestamp 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | ------- Summary: start ------- 03:33:39 INFO - PROCESS | 3854 | Number of tests: 14 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:1.97 (1.7%) stddev-sans-first:2.05 03:33:39 INFO - PROCESS | 3854 | Values: 114.0 108.0 113.0 114.0 113.0 114.0 115.0 114.0 112.0 112.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#1] audio-beat-detection Cycles:10 Average:157.50 Median:160.50 stddev:21.71 (13.5%) stddev-sans-first:23.02 03:33:39 INFO - PROCESS | 3854 | Values: 159.0 139.0 162.0 190.0 132.0 157.0 164.0 139.0 195.0 138.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.43 (2.1%) stddev-sans-first:3.62 03:33:39 INFO - PROCESS | 3854 | Values: 163.0 172.0 167.0 161.0 161.0 163.0 161.0 164.0 164.0 162.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:37.66 (48.9%) stddev-sans-first:39.39 03:33:39 INFO - PROCESS | 3854 | Values: 77.0 78.0 76.0 160.0 80.0 78.0 75.0 75.0 172.0 77.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:87.00 stddev:27.05 (31.1%) stddev-sans-first:28.09 03:33:39 INFO - PROCESS | 3854 | Values: 88.0 87.0 148.0 88.0 87.0 87.0 136.0 86.0 86.0 144.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 03:33:39 INFO - PROCESS | 3854 | Values: 118.0 118.0 118.0 117.0 118.0 119.0 118.0 119.0 117.0 119.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:33:39 INFO - PROCESS | 3854 | Values: 149.0 148.0 149.0 148.0 149.0 149.0 148.0 147.0 148.0 147.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:33:39 INFO - PROCESS | 3854 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 95.0 97.0 96.0 96.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:2.10 (3.2%) stddev-sans-first:2.22 03:33:39 INFO - PROCESS | 3854 | Values: 65.0 63.0 63.0 70.0 63.0 65.0 66.0 64.0 65.0 64.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 03:33:39 INFO - PROCESS | 3854 | Values: 65.0 64.0 67.0 66.0 65.0 66.0 64.0 65.0 66.0 65.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.50 stddev:7.12 (8.4%) stddev-sans-first:7.44 03:33:39 INFO - PROCESS | 3854 | Values: 91.0 82.0 83.0 84.0 90.0 84.0 85.0 84.0 106.0 86.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:138.00 stddev:7.89 (5.7%) stddev-sans-first:8.26 03:33:39 INFO - PROCESS | 3854 | Values: 142.0 134.0 130.0 138.0 131.0 136.0 149.0 132.0 138.0 154.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.50 stddev:3.03 (1.7%) stddev-sans-first:3.20 03:33:39 INFO - PROCESS | 3854 | Values: 173.0 175.0 172.0 175.0 172.0 166.0 174.0 172.0 176.0 169.0 03:33:39 INFO - PROCESS | 3854 | 03:33:39 INFO - PROCESS | 3854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.48 03:33:39 INFO - PROCESS | 3854 | Values: 67.0 69.0 69.0 70.0 69.0 70.0 67.0 67.0 66.0 67.0 03:33:39 INFO - PROCESS | 3854 | -------- Summary: end -------- 03:33:39 INFO - PROCESS | 3854 | 03:33:40 INFO - TEST-INFO | 3854: exit 0 03:33:40 INFO - TEST-OK | kraken | took 64544ms 03:33:40 INFO - SUITE-END | took 1184s 03:33:40 INFO - Completed test suite (00:19:44) 03:33:40 INFO - javascript benchmark 03:33:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6418.714812598488, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.5109504741617, 2661.2548486423802, 2678.5580379237426, 2681.2760554650245, 2695.231858920207, 4736.644751643627, 4750.667453278272, 4758.214894542396, 4816.8554943351755, 4840.419149702041, 4775.594074503671, 4804.83183088592, 4877.658563900528, 4888.437829649592, 4890.290907818364, 4391.121775644876, 4415.403920470743, 4501.099780043988, 4523.886902827423, 4529.07154033424, 4213.157368526292, 4478.6417086633155, 4497.033137875356, 4563.612092972101, 4576.039031803309, 4388.561143885618, 4450.087732014929, 4451.799669014902, 4464.933026004613, 4524.524924882873, 4439.911201775979, 4492.730436173807, 4502.099580083964, 4523.932141017887, 4567.406237189178, 4430.800613972379, 4449.421575195236, 4454.5990860822685, 4474.351219073216, 4493.370928070073, 4808.206645903421, 4809.23052311632, 4840.370751802243, 4849.927251091236, 4850.539198776146, 5192.55863251624, 5197.7920883164625, 5199.376074871039, 5213.139831927728, 5227.947720522822, 5034.3455350804525, 5216.869578260574, 5242.13504771716, 5245.4754524547625, 5261.0793111205385, 4899.902001959941, 4942.332785074041, 4945.159322915113, 4949.059678661043, 4999.875003124951, 5394.433584473652, 5416.7562459688625, 5418.051840927822, 5432.91850622241, 5459.454054594509, 4990.426100998432, 5026.321446604735, 5060.0, 5183.611229157828, 5194.0650682876685, 5046.192609182586, 5134.948650513447, 5153.510416510426, 5154.5103215194495, 5194.11700010999, 5134.948650513522, 5137.152369858932, 5195.636305458582, 5212.192110222922, 5213.2701421800975, 4958.057968985881, 5066.03745288394, 5175.0, 5190.455002224788, 5241.764120614582, 4370.38814565961, 4401.6698747594055, 4421.911561768747, 4446.177457170434, 4446.866594002185, 3818.5608655004476, 3832.0611450194324, 3848.807559622008, 3853.056001279648, 3856.9614303857165, 4374.78126093694, 4449.57729015743, 4451.243288640874, 4487.551244875486, 4509.346144808985, 5244.475552444801, 5299.8410047698635, 5304.522592966651, 5317.229001794795, 5334.06653835585, 4530.343100250445, 4531.365608814768, 4539.205639013159, 4553.7267763933605, 4578.908421831545, 4480.1711683338035, 4604.907901841944, 4645.0477652081245, 4666.696664716783, 4752.334673145693, 4910.165271903857, 4918.1393256180745, 4920.975395123073, 4941.2835138905375, 4991.875203119951, 5281.57747380201, 5290.465764928128, 5291.920621190762, 5293.814716484904, 5306.097963346163, 4740.502247263988, 4828.806847726051, 4845.370101886732, 4864.829730959399, 4903.26451032348, 5110.642255042111, 5129.076766181974, 5158.200478925773, 5160.922586161136, 5182.963407318627, 5078.365204349457, 5227.0, 5229.372475302988, 5233.084210263265, 5237.031149237403, 4913.729744864067, 4936.975315123402, 4949.183384741477, 4953.752312384294, 5013.949860501494, 5019.0, 5071.366079240095, 5074.137396642506, 5077.238414237746, 5081.0, 4970.801167953386, 4993.80024799004, 5001.374828146481, 5015.64890457679, 5044.9243261350375, 4938.358013458227, 5070.847874563769, 5118.513741194581, 5164.690118592896, 5169.06956747789, 4991.675541089818, 5027.271045698426, 5034.194528875362, 5036.06832735945, 5089.312942752829], "value": 4771.098457411685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.1902538201641, 590.1148277583625, 592.2478452365493, 607.8601921558042, 609.9113083146578, 34583.654163458355, 39000.0, 39188.0, 39231.0, 39421.211575768466, 38946.61053389465, 39439.80280098603, 39459.0, 39560.208795824066, 39746.8012659937, 7574.469787114904, 7679.57762323072, 7684.308412242897, 7727.72952946647, 7740.380769538451, 7687.308142267195, 7789.260020298091, 7828.373730101606, 7833.451658383887, 7840.411969102312, 7706.7302644407455, 7760.767176984699, 7766.456348055638, 7815.2966233039015, 7820.061592608895, 7704.152543220242, 7708.38332933364, 7734.458587898849, 7742.729004484844, 7768.262015108556, 7613.0483689538805, 7700.845983080307, 7701.884471732872, 7717.7298794542485, 7752.418568607377, 36847.0, 36998.81500592507, 37025.0, 37264.44103338452, 37394.25211495782, 2590.4042070323744, 2943.5290353543546, 2975.0, 3064.2798942248555, 3098.1634958561062, 27372.45255094907, 27853.86073069642, 28096.157115286573, 28244.576331355045, 28675.856620716764, 3277.36091462165, 3357.076803878953, 3378.797272163678, 3384.813835239061, 3404.2510647657477, 225580.0, 225850.0, 227221.0, 227327.0, 227786.0, 31179.688203118134, 31579.52630710541, 31789.364212715616, 31811.522827157612, 31853.362932741216, 31389.52915706266, 31501.0, 31526.684733152833, 31582.842085789423, 31653.20866978298, 13592.38834252461, 13603.115797473132, 13619.114757540729, 13717.657058573615, 13794.0, 11465.31208127515, 11698.649040528799, 11699.122565807598, 11704.297742135499, 11745.354005529778, 7840.921590784019, 7852.84294314122, 7871.307668851225, 7907.2488113629115, 7927.920720792834, 3088.6448058473115, 3125.46867032605, 3135.0751528299206, 3179.5071763876635, 3198.9200269993435, 894.6287290774255, 939.8167357365248, 946.1910066892846, 971.0144203633317, 988.9703308900745, 27304.180874573794, 28513.714862851106, 28622.713772862422, 28752.913174988676, 28831.71168288332, 950.8716323296267, 954.2413781044087, 982.3712823792779, 1037.8287582548946, 1040.8646875906084, 14973.925130374279, 14981.775273370908, 15051.247437628075, 15082.773758393632, 15309.234538273042, 388433.0, 388655.0, 391675.0, 394440.0, 398283.0, 48942.510574894506, 49818.25272620914, 50083.24875126876, 50098.24852627214, 50158.247626285636, 1157.2593540134321, 1203.7231436769591, 1204.6687161030611, 1209.9879001210052, 1222.4132416440336, 26752.59871101896, 27245.182644520697, 27783.824807022003, 28461.146165615064, 28517.42965140727, 42295.5770442304, 42498.0, 42874.0, 42962.78518607387, 42982.0, 260869.0, 260905.0, 260960.0, 261348.0, 262411.0, 24974.0, 25029.49941001206, 25191.11831085903, 25419.491610167323, 25432.0, 41693.166136677704, 42139.0, 42506.0, 42815.0, 43388.132237355705, 35947.640523594426, 36173.0, 36323.091922702144, 36556.26887462289, 36940.6305936948, 35772.0, 36053.81973090118, 36457.0, 36496.0, 36950.81524592467, 35317.82341088278, 35446.645533545365, 35633.0, 36266.0, 36469.08827279339, 31682.366352673278, 32546.837265814465, 33030.33939321152, 33076.83461582677, 33159.33681326408, 24460.6330905033, 25130.37174070663, 25529.23412297634, 25533.9786408549, 25634.743652563237], "value": 16099.03954351323, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.94250391189365, 371.17228580266004, 371.51146242690874, 387.4111350746867, 396.0613346369104, 16205.513834584966, 16527.338906443743, 17095.14524273786, 17171.0, 18159.45521634353, 17530.64938701225, 18625.906870465627, 18651.0, 18922.810771892277, 19625.509362265915, 5598.720063996804, 5820.38885916979, 5878.50032747217, 5887.0, 5907.497862681677, 5216.6869987800665, 7051.47113966452, 7065.116860392451, 7156.391706704936, 7201.027861238745, 7099.787006389816, 7171.928280717204, 7184.317489838483, 7233.710651573931, 7258.3104605062435, 6771.661416929159, 6886.931130688679, 6953.408960238386, 6969.05917701109, 6988.126484189476, 6631.86736265272, 6798.966005169992, 6810.421114205249, 6851.314868513158, 6864.347886950732, 20384.796152038438, 22701.97841097138, 22748.88625556878, 23424.531509369717, 23476.413089672726, 1955.1104247567323, 2003.388966365258, 2077.657186564215, 2169.1540299283292, 2387.331547166796, 13725.588232353046, 14017.0, 14110.223937683424, 14765.77851332231, 14967.101973881601, 1795.5511122219445, 1827.6566723458247, 1836.8163183681659, 1866.925322987079, 1937.0508450859118, 78023.92844465091, 82826.0, 83160.58419707924, 83217.58391208066, 84270.57864710699, 16163.43427980015, 16885.83114168867, 17291.39480118215, 17451.73822392665, 17665.0, 28575.14274571766, 28588.571171432446, 29487.852560737058, 29506.0, 29536.113916582537, 8957.14907083839, 9042.0, 9145.176934075966, 9434.905650943403, 9459.574319155654, 7252.202257751643, 7362.963185184147, 7441.776746697607, 7496.362809161283, 7523.435742319239, 3527.6472352764517, 3862.362710152793, 8312.501249925024, 8398.664053437917, 8507.276881465144, 1842.870999030055, 1873.4660621722744, 1877.474307193988, 1894.1381671339507, 1927.5015846239312, 828.5939889454124, 856.002756788347, 861.2894362151251, 881.6076845803684, 922.6770630279483, 16422.0, 16599.751003734953, 16639.916800415922, 16963.491095267163, 17385.913070434566, 819.6844214977276, 857.3012994409661, 888.560162719458, 895.8778656382502, 941.4398432932394, 9111.81776364469, 9422.717318480456, 9431.905680943102, 9437.103475169848, 9625.903740962502, 367620.0, 371824.0, 375175.0, 376627.0, 381982.0, 45700.54299457029, 46434.303485447745, 46525.30212046822, 47832.76083619629, 48003.27995080077, 851.2764150472173, 875.9562021899008, 881.8148188880278, 896.4710820615868, 899.59967814322, 14876.586724261178, 15093.396264149751, 15107.622309442351, 15157.242137893281, 15558.766618500506, 24825.376481896543, 26363.077292294678, 35538.46692299669, 36215.042651815165, 37002.814985924895, 47209.52790472051, 48121.518784811706, 49043.50956490389, 49416.0, 49573.75213124056, 6358.205224346957, 6571.80284591463, 6779.322067793379, 6919.6886140124825, 6981.5112942093565, 11007.0, 12354.135210535176, 12364.876351236373, 12583.87416125827, 12756.808647870104, 10205.336653117523, 10358.378497290187, 10454.11140053104, 10513.474326283502, 10516.68449946503, 10592.735181620521, 10777.62278320255, 10793.514291856729, 10929.234953553492, 10950.233483656068, 9834.0, 9991.400515969066, 10602.89397106019, 10767.114717142413, 10791.0, 7682.577458239851, 7838.608069596611, 8028.718994835152, 8101.635426405708, 8108.067572229269, 7946.165652606393, 9048.502332371783, 10001.74995625086, 10064.144547713233, 10538.57845686164], "value": 8999.738354273351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.223621417685, 1384.1349156777014, 1460.7297649934762, 1652.0748380906693, 1659.8589119924807, 6859.657017149148, 7411.258874112586, 7562.848743025136, 8069.152738962405, 8075.0, 7573.659185336659, 7701.152873183959, 7759.41804364672, 7819.530828150315, 7867.291943725064, 2167.122315462236, 2232.2968264996475, 2251.718535183102, 2256.041182497432, 2261.4798596322858, 2174.5650869826018, 2188.4310079379316, 2234.6089434349005, 2238.1271304191378, 2246.4608493961496, 2228.1644383356243, 2248.6739422783685, 2249.280230326296, 2252.4706693926914, 2271.772822717723, 2203.6914831923464, 2204.713387259662, 2211.303439416579, 2218.900149493277, 2219.94450138747, 2189.9343019709436, 2194.9451263718533, 2200.1639377036786, 2222.5665995130958, 2223.444138965259, 7757.301842834116, 7899.289063984269, 7900.960495197544, 7905.604719764046, 7916.445848790587, 4584.770761461947, 4661.696989695659, 4698.365720627706, 4699.459562150328, 4702.694324868872, 2991.536311871642, 3021.7884748067645, 3124.6719094495206, 3156.71589556941, 3168.8415579220946, 984.306064224727, 992.3153024413205, 992.3995982430598, 1011.6762635956497, 1023.9436830974294, 10699.625513107081, 10967.177461690326, 10999.670009899715, 11014.229003969725, 11016.0, 4188.827128403991, 4220.767857767791, 4250.57605702087, 4379.715318504287, 4385.890352741207, 9377.906220937839, 9435.622575097057, 9447.196988255937, 9461.952690236643, 9486.33595648298, 4740.146773580788, 4747.976260118678, 4748.548887855648, 4754.334393184957, 4755.762211889391, 3751.8499260029294, 4162.709560036398, 4169.499660040815, 4298.26929421999, 4309.827606895752, 3668.853245870135, 3715.275521273326, 3767.3972164453558, 3798.088458769875, 3910.8631197907935, 1174.7650469906052, 1222.3949145173196, 1223.7919553675897, 1226.8221107939298, 1236.7526494700917, 766.9156392796788, 864.4597126795753, 890.9376343655882, 892.9642814287486, 904.4482865452069, 5456.372517160498, 5464.9180262296095, 5596.860078497989, 5625.184348269478, 5738.368779434259, 403.6710081283744, 410.8438793258543, 414.2708832454841, 417.74308800087726, 422.6365325819792, 3828.9617103829164, 3832.5017747692623, 3901.1027463683513, 3938.1532970410926, 3983.342748446532, 9549.761255968657, 9782.51087445625, 9827.4103553787, 9874.506274686237, 9890.258230632731, 9636.277279203947, 9675.177609903096, 9730.61077556904, 9793.363431376938, 9861.852072218779, 7231.493795434374, 7277.163126240444, 7292.854142917112, 7315.158756742936, 7344.0, 5465.7813687453645, 5489.752961116679, 5490.845267063015, 5519.3652729936575, 5596.664200148004, 9029.41308814925, 9098.0, 9194.632214711337, 9209.677661281823, 9235.353525253167, 8986.551656929862, 9136.26909847224, 9278.489683067226, 9288.72133835986, 9288.860667090134, 6125.663088530174, 6770.1537307836525, 6834.760783372558, 6896.413804826646, 6906.447484201352, 7594.8860767087435, 7650.732224372343, 7655.0813902332075, 7661.770146895602, 7695.23047695226, 6671.966640166962, 6784.185897692309, 6843.863122737418, 6874.175098988154, 7005.859882802213, 6831.2144103428745, 6857.5199736018, 6869.381755641816, 6900.30996900326, 6997.055397521473, 5876.853078673067, 5878.147668588116, 5896.056630939029, 5935.34711181761, 6091.756329746938, 4356.477222733292, 4363.738175709467, 4378.277584198571, 4433.113377324484, 4460.018795864905, 4649.093426781745, 4666.2767271073035, 4666.510016448224, 4697.1545121877025, 4716.551927566876], "value": 4139.407888224723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.8927291538589, 309.622260841773, 313.8101448623582, 316.225248142052, 316.74976768353, 4928.5564299213065, 5018.523240292176, 5055.772490237939, 5161.406438259602, 5211.713355765436, 5057.342545469084, 5105.489451054902, 5111.361079865017, 5115.693058416488, 5134.922976155361, 3972.781497017663, 3999.7400168988925, 4016.979915100435, 4027.234825383168, 4057.6550993165615, 3977.3835055566433, 3977.443157957888, 3983.3228351180223, 4021.2158629067344, 4059.7361171523903, 3954.8841369867127, 3965.2267807777494, 3974.4435778990965, 3974.8075577326686, 3987.162695833864, 3959.0, 3994.580569040267, 4000.719949603529, 4013.257547353749, 4038.3336749436307, 3540.132667496454, 3572.8749493767855, 3574.6782789548806, 3581.6776490116013, 3582.6417358264225, 4758.643101767347, 4992.276119962585, 4992.301077849104, 5003.524665156804, 5068.5691716204165, 4581.106684196583, 4618.745968971705, 4619.3438772705495, 4622.699524530894, 4633.235516139833, 5385.7307134643115, 5391.137418013099, 5397.676139431646, 5402.567794576464, 5408.945910540883, 3784.7539909906045, 3842.654161125512, 3868.2650296443867, 3869.825857836376, 3913.3151698452943, 5595.964746521907, 5611.887762244733, 5619.6066275360745, 5658.179563963244, 5666.206731057655, 3977.164795393, 3981.163955569305, 3997.760134391946, 4002.6597739192493, 4002.899927501836, 3700.50043244164, 3942.6792024672054, 4050.513938327361, 4075.735077219971, 4076.9388459173138, 4460.34967062189, 4486.743711760712, 4493.146302202636, 4494.4157259556705, 4515.864524064284, 5282.0456431119965, 5296.417394086648, 5301.973490132602, 5304.575633949352, 5304.9734751326, 1260.1682889293022, 1304.1327517201146, 1346.3201083452793, 1348.2854087333728, 1356.165957935882, 835.4653022065883, 851.9105493923173, 854.7264875239864, 863.9006514250941, 872.5113936195623, 4175.770332631734, 4183.937240941388, 4235.512916014636, 4256.127493863751, 4263.25206665272, 4868.586170175504, 4874.806337148298, 4894.951050489521, 4897.951020489821, 4900.990593856502, 4156.937645935313, 4202.285611446062, 4206.200821843901, 4215.156968606291, 4221.303484925014, 2514.911978080758, 2591.1708253358743, 2613.2944105091897, 2619.8428094314404, 2620.6986196587254, 4525.389072475239, 4552.93006143556, 4557.635389168859, 4581.633469322513, 4627.5603817637275, 4927.4768540493715, 4964.776585053609, 4971.527704868032, 5050.090983622909, 5069.290299358093, 4334.956650433455, 4620.5148459411275, 4637.6289896808175, 4643.535646435397, 4645.374119058302, 4927.162382395073, 4947.282644016669, 4950.430700469492, 4965.925511117264, 4970.353853999101, 4689.320048593003, 4748.264019077049, 4765.904681906273, 4776.713397196179, 4780.0, 4332.783360831882, 4560.6807523473035, 4575.794089266057, 4588.816447342069, 4590.403247577793, 3511.139096278976, 3515.472679098156, 3529.470579413006, 3532.805695686659, 3569.518115054538, 4915.287283343823, 4924.458309585871, 4931.432885218246, 4940.270905183157, 5287.625217443569, 5219.373675159005, 5263.842084737464, 5336.67979921206, 5374.3013408256675, 5391.598184471987, 5271.182966640177, 5321.281626980308, 5324.680519168863, 5336.386315573759, 5362.785488580413, 5191.092987926773, 5198.558122559625, 5203.543007957778, 5240.0, 5242.318498595311, 5286.471352864683, 5327.813526526553, 5333.280007199133, 5384.784608615611, 5386.596005299697, 5217.2434996925995, 5263.421023687468, 5308.4160742317545, 5310.2831117798605, 5330.920036199538], "value": 3878.191030020598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.2334228898455, 671.506442764568, 689.6379400814568, 704.4892452971594, 726.9967444926001, 11949.522019119237, 12209.26744395337, 12614.936925315373, 12790.168639038457, 13274.933625331883, 13204.207747535154, 13232.404541795619, 13245.13906596073, 13252.0, 13270.867291327084, 619.5910698938701, 769.8075481129717, 788.2866006264326, 797.8523973064972, 808.9474184178009, 785.4344871692401, 790.7074382478492, 791.7110254757001, 792.742358733411, 797.1390897830329, 836.564986207172, 837.815680550278, 839.3872473094644, 839.890814194157, 840.8276303357827, 833.4624167412046, 833.9207775261341, 836.7406104107715, 839.1901814748766, 840.1136800675285, 608.9117078023662, 610.9541784366146, 611.9571629985903, 613.3743581546842, 615.7536985205909, 12344.938275308656, 12350.44423000967, 12370.81443778344, 12394.0, 12400.81398779019, 13299.0, 13640.40121762567, 13905.86094139066, 14136.081154725012, 14211.50259740904, 10489.213309001856, 10496.265261431703, 10528.210384221215, 10569.630062947837, 10629.73425664357, 3374.9156271093175, 3397.3205358928067, 3403.4894765785084, 3416.7437442191936, 3485.2158264390564, 62127.689361552904, 62584.687076564325, 62607.0, 62865.68567157181, 62970.37029629691, 9948.0, 10477.68566942993, 10737.624183153708, 10751.139908807432, 10871.891281087088, 18157.636847263246, 18200.817991819913, 18247.908760456114, 18282.817171828112, 18330.725039124423, 6878.484113691393, 6882.827929301808, 6935.6878940447805, 7049.859002819915, 7101.680424380916, 3685.760425572329, 3723.9627603724157, 3751.756135851161, 3776.9433458498142, 3794.658480736747, 2824.0680575410065, 2878.136559032282, 2898.9130326090253, 2903.0, 2906.462304473679, 517.5549027836058, 520.8801975545646, 521.0932976620728, 529.7907326606046, 530.2920600997711, 487.8731529802277, 553.347050480429, 570.8173384516915, 575.3498546642351, 580.0124146492861, 7739.264769846855, 7985.843822167982, 8059.919400805917, 8066.717664881701, 8106.675732970615, 450.8512190977035, 510.84163909187527, 514.143950322716, 550.2928736573564, 580.3442110415289, 3602.7838329699775, 3631.7358449455555, 3667.633236676311, 3670.284294562588, 3807.3908174691915, 90810.54594726984, 92164.53917730368, 92580.53709731543, 94188.52905735564, 94835.0, 81157.0, 81798.59100704458, 83428.0, 84011.5799420999, 84291.5785421069, 58655.70672146697, 70992.64503677552, 74781.62609187028, 75384.62307688427, 75433.0, 7002.299770023161, 7127.429805615642, 7193.604351760494, 7217.747378841926, 7289.927100728924, 37975.810120949216, 42664.78667606642, 44108.0, 44282.77858610686, 45772.7711361441, 61048.084278736744, 65196.0, 65802.67098664476, 65840.34159658341, 65940.67029664821, 9802.705918822447, 9910.35582687123, 10090.09189172978, 10114.494275286059, 10131.949340253252, 10401.53193106297, 10449.634262800766, 10613.0, 10624.468776561296, 10713.892861071601, 10151.238657100896, 10250.58997640086, 10255.179585632983, 10264.127549158107, 10462.110720588835, 9629.0, 9781.657641982496, 9800.754981125529, 9909.504524773589, 10079.848802268118, 9718.562664680248, 9769.0, 9878.950605247215, 9903.45530995802, 9955.104040636088, 8331.875021874797, 8686.348523860863, 8793.692220772242, 8891.4665120093, 8897.73306800797, 7808.57052862098, 8018.639161237875, 8194.631241594023, 8250.669973201006, 8554.657813687383], "value": 6301.250242927407, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 112.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 139.0, 162.0, 190.0, 132.0, 157.0, 164.0, 139.0, 195.0, 138.0], "value": 157.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 167.0, 161.0, 161.0, 163.0, 161.0, 164.0, 164.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 160.0, 80.0, 78.0, 75.0, 75.0, 172.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 148.0, 88.0, 87.0, 87.0, 136.0, 86.0, 86.0, 144.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 119.0, 117.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 70.0, 63.0, 65.0, 66.0, 64.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 66.0, 65.0, 66.0, 64.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 83.0, 84.0, 90.0, 84.0, 85.0, 84.0, 106.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 134.0, 130.0, 138.0, 131.0, 136.0, 149.0, 132.0, 138.0, 154.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 172.0, 175.0, 172.0, 166.0, 174.0, 172.0, 176.0, 169.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 70.0, 69.0, 70.0, 67.0, 67.0, 66.0, 67.0], "value": 68.1, "unit": "score"}]}]} 03:33:40 INFO - Return code: 0 03:33:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:33:40 ERROR - # TBPL SUCCESS # 03:33:40 INFO - Running post-action listener: _resource_record_post_action 03:33:40 INFO - ##### 03:33:40 INFO - ##### Finished run-tests step (success) 03:33:40 INFO - ##### 03:33:40 INFO - Running post-run listener: _resource_record_post_run 03:33:40 INFO - Total resource usage - Wall time: 1202s; CPU: 14.0%; Read bytes: 7700480; Write bytes: 311435264; Read time: 908; Write time: 266368 03:33:40 INFO - TinderboxPrint: CPU usage
13.5% 03:33:40 INFO - TinderboxPrint: I/O read bytes / time
7,700,480 / 908 03:33:40 INFO - TinderboxPrint: I/O write bytes / time
311,435,264 / 266,368 03:33:40 INFO - TinderboxPrint: CPU idle
8,288.8 (86.4%) 03:33:40 INFO - TinderboxPrint: CPU user
1,239.8 (12.9%) 03:33:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:33:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17170432; Read time: 0; Write time: 5872 03:33:40 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 5939200; Write bytes: 294264832; Read time: 872; Write time: 260496 03:33:41 INFO - Running post-run listener: _upload_blobber_files 03:33:41 INFO - Blob upload gear active. 03:33:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:33:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:33:41 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:33:41 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:33:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:42 INFO - (blobuploader) - INFO - Done attempting. 03:33:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:33:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:46 INFO - (blobuploader) - INFO - Done attempting. 03:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:33:47 INFO - (blobuploader) - INFO - Done attempting. 03:33:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:33:47 INFO - Return code: 0 03:33:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:33:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:33:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/255a6381a8a2c91f0d1db3044d60e855a7febe60f2043f05b8d281900518946a45593cca10c6ec3f30825504831484e2f4f816abba4d34795474a15ba32ea6c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11300969694a6305e580ea9dd4e020715a4fd71d5701d5afc999970d269fe9fa538eaec40aaf29ad3040ebc3aa5ff40016b9e94bde6417f76c3ba1568b1f2696", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2be383f4022f3e10bca096b9494045e683d2478acf9ed6d5bb4529addfe166a6ccc6b0efc3f5059f5a25c03ee4342823c709410c0d62103d5d3de0b29ea1e58"} 03:33:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:33:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:33:47 INFO - Contents: 03:33:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/255a6381a8a2c91f0d1db3044d60e855a7febe60f2043f05b8d281900518946a45593cca10c6ec3f30825504831484e2f4f816abba4d34795474a15ba32ea6c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11300969694a6305e580ea9dd4e020715a4fd71d5701d5afc999970d269fe9fa538eaec40aaf29ad3040ebc3aa5ff40016b9e94bde6417f76c3ba1568b1f2696", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2be383f4022f3e10bca096b9494045e683d2478acf9ed6d5bb4529addfe166a6ccc6b0efc3f5059f5a25c03ee4342823c709410c0d62103d5d3de0b29ea1e58"} 03:33:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:33:47 INFO - Copying logs to upload dir... 03:33:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:33:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.223499 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-06-22 03:33:47.160860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:47.164546) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/255a6381a8a2c91f0d1db3044d60e855a7febe60f2043f05b8d281900518946a45593cca10c6ec3f30825504831484e2f4f816abba4d34795474a15ba32ea6c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11300969694a6305e580ea9dd4e020715a4fd71d5701d5afc999970d269fe9fa538eaec40aaf29ad3040ebc3aa5ff40016b9e94bde6417f76c3ba1568b1f2696", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2be383f4022f3e10bca096b9494045e683d2478acf9ed6d5bb4529addfe166a6ccc6b0efc3f5059f5a25c03ee4342823c709410c0d62103d5d3de0b29ea1e58"} build_url:https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/VJm5rOAwSOa2TvVjr2aZIw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/255a6381a8a2c91f0d1db3044d60e855a7febe60f2043f05b8d281900518946a45593cca10c6ec3f30825504831484e2f4f816abba4d34795474a15ba32ea6c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/11300969694a6305e580ea9dd4e020715a4fd71d5701d5afc999970d269fe9fa538eaec40aaf29ad3040ebc3aa5ff40016b9e94bde6417f76c3ba1568b1f2696", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2be383f4022f3e10bca096b9494045e683d2478acf9ed6d5bb4529addfe166a6ccc6b0efc3f5059f5a25c03ee4342823c709410c0d62103d5d3de0b29ea1e58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:47.190062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:47.190416) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466588259.570934-1243485786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 03:33:47.275110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:33:47.275466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 03:33:47.275748) ========= ========= Total master_lag: 0.21 =========