builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1465238671.76 results: success (0) buildid: 20160606083115 builduid: b8910be4b18a4cf09cdff0b9cc7cee10 revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.756414) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.757372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.757702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.772730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.773188) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:44:32-- 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% 46.1M=0s 2016-06-06 11:44:32 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.908908) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.909641) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017577 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.963908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:31.964746) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8ee8066ffeea90aabada756a2126349680bccb37 --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 8ee8066ffeea90aabada756a2126349680bccb37 --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=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:44:32,419 truncating revision to first 12 chars 2016-06-06 11:44:32,419 Setting DEBUG logging. 2016-06-06 11:44:32,419 attempt 1/10 2016-06-06 11:44:32,419 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8ee8066ffeea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 11:44:32,793 unpacking tar archive at: fx-team-8ee8066ffeea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718506 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:32.701275) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:32.701980) ========= script_repo_revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:32.702940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:32.703516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:44:32.715091) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 56 secs) (at 2016-06-06 11:44:32.715391) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:44:33 INFO - MultiFileLogger online at 20160606 11:44:33 in /builds/slave/test 11:44:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:44:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:33 INFO - {'append_to_log': False, 11:44:33 INFO - 'base_work_dir': '/builds/slave/test', 11:44:33 INFO - 'blob_upload_branch': 'Fx-Team', 11:44:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:33 INFO - 'branch': 'Fx-Team', 11:44:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:33 INFO - 'config_files': ('talos/linux_config.py',), 11:44:33 INFO - 'default_actions': ('clobber', 11:44:33 INFO - 'read-buildbot-config', 11:44:33 INFO - 'download-and-extract', 11:44:33 INFO - 'populate-webroot', 11:44:33 INFO - 'create-virtualenv', 11:44:33 INFO - 'install', 11:44:33 INFO - 'run-tests'), 11:44:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:33 INFO - 'download_minidump_stackwalk': True, 11:44:33 INFO - 'download_symbols': 'ondemand', 11:44:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:33 INFO - 'installer_path': 'installer.exe', 11:44:33 INFO - 'log_level': 'info', 11:44:33 INFO - 'log_name': 'talos', 11:44:33 INFO - 'log_to_console': True, 11:44:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:44:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:44:33 INFO - 'opt_config_files': (), 11:44:33 INFO - 'pip_index': False, 11:44:33 INFO - 'sps_profile': False, 11:44:33 INFO - 'sps_profile_interval': 0, 11:44:33 INFO - 'suite': 'dromaeojs-e10s', 11:44:33 INFO - 'system_bits': '32', 11:44:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:33 INFO - 'title': 'talos-linux64-ix-012', 11:44:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:33 INFO - 'use_talos_json': True, 11:44:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:33 INFO - 'work_dir': 'build'} 11:44:33 INFO - ##### 11:44:33 INFO - ##### Running clobber step. 11:44:33 INFO - ##### 11:44:33 INFO - Running pre-action listener: _resource_record_pre_action 11:44:33 INFO - Running main action method: clobber 11:44:33 INFO - rmtree: /builds/slave/test/build 11:44:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:33 INFO - Running post-action listener: _resource_record_post_action 11:44:33 INFO - ##### 11:44:33 INFO - ##### Finished clobber step (success) 11:44:33 INFO - ##### 11:44:33 INFO - ##### 11:44:33 INFO - ##### Running read-buildbot-config step. 11:44:33 INFO - ##### 11:44:33 INFO - Running pre-action listener: _resource_record_pre_action 11:44:33 INFO - Running main action method: read_buildbot_config 11:44:33 INFO - Using buildbot properties: 11:44:33 INFO - { 11:44:33 INFO - "project": "", 11:44:33 INFO - "product": "firefox", 11:44:33 INFO - "script_repo_revision": "production", 11:44:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:44:33 INFO - "repository": "", 11:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:44:33 INFO - "buildid": "20160606083115", 11:44:33 INFO - "pgo_build": "True", 11:44:33 INFO - "basedir": "/builds/slave/test", 11:44:33 INFO - "buildnumber": 813, 11:44:33 INFO - "slavename": "talos-linux64-ix-012", 11:44:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:44:33 INFO - "platform": "ubuntu64_hw", 11:44:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:44:33 INFO - "branch": "fx-team", 11:44:33 INFO - "repo_path": "integration/fx-team", 11:44:33 INFO - "revision": "8ee8066ffeea90aabada756a2126349680bccb37", 11:44:33 INFO - "stage_platform": "linux64-pgo", 11:44:33 INFO - "builduid": "b8910be4b18a4cf09cdff0b9cc7cee10", 11:44:33 INFO - "slavebuilddir": "test" 11:44:33 INFO - } 11:44:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:44:33 INFO - Running post-action listener: _resource_record_post_action 11:44:33 INFO - ##### 11:44:33 INFO - ##### Finished read-buildbot-config step (success) 11:44:33 INFO - ##### 11:44:33 INFO - ##### 11:44:33 INFO - ##### Running download-and-extract step. 11:44:33 INFO - ##### 11:44:33 INFO - Running pre-action listener: _resource_record_pre_action 11:44:33 INFO - Running main action method: download_and_extract 11:44:33 INFO - mkdir: /builds/slave/test/build/tests 11:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:44:33 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:44:35 INFO - Downloaded 1361 bytes. 11:44:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:44:35 INFO - Using the following test package requirements: 11:44:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:44:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:44:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:44:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'jsshell-linux-x86_64.zip'], 11:44:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:44:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:44:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:44:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:44:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:44:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:44:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:44:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:44:35 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')]} 11:44:35 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:47:58 INFO - Downloaded 24443794 bytes. 11:47:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:47:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:47:59 INFO - Return code: 0 11:47:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:59 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:47:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:47:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:47:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:02 INFO - Downloaded 24443794 bytes. 11:48:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:48:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:48:04 INFO - Return code: 0 11:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:04 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:48:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:48:05 INFO - Downloaded 10833369 bytes. 11:48:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:48:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:48:05 INFO - Return code: 0 11:48:05 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')]} 11:48:05 INFO - https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:48:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:48:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:48:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:48:07 INFO - Downloaded 59181725 bytes. 11:48:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:48:07 INFO - mkdir: /builds/slave/test/properties 11:48:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:07 INFO - Contents: 11:48:07 INFO - build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:48:08 INFO - Running post-action listener: _resource_record_post_action 11:48:08 INFO - Running post-action listener: set_extra_try_arguments 11:48:08 INFO - ##### 11:48:08 INFO - ##### Finished download-and-extract step (success) 11:48:08 INFO - ##### 11:48:08 INFO - ##### 11:48:08 INFO - ##### Running populate-webroot step. 11:48:08 INFO - ##### 11:48:08 INFO - Running pre-action listener: _resource_record_pre_action 11:48:08 INFO - Running main action method: populate_webroot 11:48:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:08 INFO - '--tppagecycles', 11:48:08 INFO - '7'], 11:48:08 INFO - 'tests': ['tsvgm']}}, 11:48:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:48:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:48:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['damp', 'tps']}, 11:48:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'tests': ['damp', 'tps']}, 11:48:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['dromaeo_dom']}, 11:48:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['a11yr', 11:48:08 INFO - 'ts_paint', 11:48:08 INFO - 'tpaint', 11:48:08 INFO - 'sessionrestore', 11:48:08 INFO - 'sessionrestore_no_auto_restore', 11:48:08 INFO - 'tabpaint']}, 11:48:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['tsvgx', 11:48:08 INFO - 'tsvgr_opacity', 11:48:08 INFO - 'tart', 11:48:08 INFO - 'tscrollx', 11:48:08 INFO - 'cart']}, 11:48:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:48:08 INFO - 'tsvgr_opacity', 11:48:08 INFO - 'tart', 11:48:08 INFO - 'tscrollx', 11:48:08 INFO - 'cart']}, 11:48:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'talos_options': ['--disable-e10s'], 11:48:08 INFO - 'tests': ['tp5o']}, 11:48:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'tests': ['tp5o']}, 11:48:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'talos_options': ['--disable-e10s', 11:48:08 INFO - '--xperf_path', 11:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:08 INFO - 'tests': ['tp5n']}, 11:48:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:08 INFO - 'talos_options': ['--xperf_path', 11:48:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:08 INFO - 'tests': ['tp5n']}}, 11:48:08 INFO - 'talos.zip': {'path': '', 11:48:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:08 INFO - Running post-action listener: _resource_record_post_action 11:48:08 INFO - ##### 11:48:08 INFO - ##### Finished populate-webroot step (success) 11:48:08 INFO - ##### 11:48:08 INFO - ##### 11:48:08 INFO - ##### Running create-virtualenv step. 11:48:08 INFO - ##### 11:48:08 INFO - Running pre-action listener: _resource_record_pre_action 11:48:08 INFO - Running main action method: create_virtualenv 11:48:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:08 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 11:48:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:08 INFO - Using real prefix '/usr' 11:48:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:10 INFO - Installing pip.................done. 11:48:10 INFO - Return code: 0 11:48:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:10 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')]} 11:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:10 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')]} 11:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:10 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:10 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 11:48:10 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 11:48:10 INFO - Using env: {'DISPLAY': ':0', 11:48:10 INFO - 'HOME': '/home/cltbld', 11:48:10 INFO - 'LANG': 'en_US.UTF-8', 11:48:10 INFO - 'LANGUAGE': 'en_US:en', 11:48:10 INFO - 'LOGNAME': 'cltbld', 11:48:10 INFO - 'MAIL': '/var/mail/cltbld', 11:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:10 INFO - 'MOZ_NO_REMOTE': '1', 11:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:10 INFO - 'NO_EM_RESTART': '1', 11:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:10 INFO - 'PWD': '/builds/slave/test', 11:48:10 INFO - 'SHELL': '/bin/bash', 11:48:10 INFO - 'SHLVL': '1', 11:48:10 INFO - 'TERM': 'linux', 11:48:10 INFO - 'TMOUT': '86400', 11:48:10 INFO - 'USER': 'cltbld', 11:48:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:10 INFO - '_': '/tools/buildbot/bin/python'} 11:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:10 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 11:48:10 INFO - Cleaning up... 11:48:10 INFO - Return code: 0 11:48:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:48:10 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')]} 11:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:10 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')]} 11:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:10 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:10 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 11:48:10 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 11:48:10 INFO - Using env: {'DISPLAY': ':0', 11:48:10 INFO - 'HOME': '/home/cltbld', 11:48:10 INFO - 'LANG': 'en_US.UTF-8', 11:48:10 INFO - 'LANGUAGE': 'en_US:en', 11:48:10 INFO - 'LOGNAME': 'cltbld', 11:48:10 INFO - 'MAIL': '/var/mail/cltbld', 11:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:10 INFO - 'MOZ_NO_REMOTE': '1', 11:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:10 INFO - 'NO_EM_RESTART': '1', 11:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:10 INFO - 'PWD': '/builds/slave/test', 11:48:10 INFO - 'SHELL': '/bin/bash', 11:48:10 INFO - 'SHLVL': '1', 11:48:10 INFO - 'TERM': 'linux', 11:48:10 INFO - 'TMOUT': '86400', 11:48:10 INFO - 'USER': 'cltbld', 11:48:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:10 INFO - '_': '/tools/buildbot/bin/python'} 11:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:11 INFO - Downloading/unpacking psutil>=3.1.1 11:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:13 INFO - Installing collected packages: psutil 11:48:13 INFO - Running setup.py install for psutil 11:48:13 INFO - building 'psutil._psutil_linux' extension 11:48:13 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 11:48:13 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 11:48:13 INFO - building 'psutil._psutil_posix' extension 11:48:13 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 11:48:13 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 11:48:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:13 INFO - Successfully installed psutil 11:48:13 INFO - Cleaning up... 11:48:13 INFO - Return code: 0 11:48:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:48: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 mozsystemmonitor==0.3 11:48:13 INFO - Using env: {'DISPLAY': ':0', 11:48:13 INFO - 'HOME': '/home/cltbld', 11:48:13 INFO - 'LANG': 'en_US.UTF-8', 11:48:13 INFO - 'LANGUAGE': 'en_US:en', 11:48:13 INFO - 'LOGNAME': 'cltbld', 11:48:13 INFO - 'MAIL': '/var/mail/cltbld', 11:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:13 INFO - 'MOZ_NO_REMOTE': '1', 11:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:13 INFO - 'NO_EM_RESTART': '1', 11:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:13 INFO - 'PWD': '/builds/slave/test', 11:48:13 INFO - 'SHELL': '/bin/bash', 11:48:13 INFO - 'SHLVL': '1', 11:48:13 INFO - 'TERM': 'linux', 11:48:13 INFO - 'TMOUT': '86400', 11:48:13 INFO - 'USER': 'cltbld', 11:48:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:13 INFO - '_': '/tools/buildbot/bin/python'} 11:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:15 INFO - Installing collected packages: mozsystemmonitor 11:48:15 INFO - Running setup.py install for mozsystemmonitor 11:48:15 INFO - Successfully installed mozsystemmonitor 11:48:15 INFO - Cleaning up... 11:48:15 INFO - Return code: 0 11:48:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:48:15 INFO - Using env: {'DISPLAY': ':0', 11:48:15 INFO - 'HOME': '/home/cltbld', 11:48:15 INFO - 'LANG': 'en_US.UTF-8', 11:48:15 INFO - 'LANGUAGE': 'en_US:en', 11:48:15 INFO - 'LOGNAME': 'cltbld', 11:48:15 INFO - 'MAIL': '/var/mail/cltbld', 11:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:15 INFO - 'MOZ_NO_REMOTE': '1', 11:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:15 INFO - 'NO_EM_RESTART': '1', 11:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:15 INFO - 'PWD': '/builds/slave/test', 11:48:15 INFO - 'SHELL': '/bin/bash', 11:48:15 INFO - 'SHLVL': '1', 11:48:15 INFO - 'TERM': 'linux', 11:48:15 INFO - 'TMOUT': '86400', 11:48:15 INFO - 'USER': 'cltbld', 11:48:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:15 INFO - '_': '/tools/buildbot/bin/python'} 11:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:16 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 11:48:16 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 11:48:16 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 11:48:16 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 11:48:16 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 11:48:16 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 11:48:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:18 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:18 INFO - warning: no files found matching '*.txt' 11:48:18 INFO - no previously-included directories found matching 'build' 11:48:18 INFO - no previously-included directories found matching 'dist' 11:48:18 INFO - no previously-included directories found matching '.git*' 11:48:18 INFO - Installing collected packages: jsonschema, functools32 11:48:18 INFO - Running setup.py install for functools32 11:48:18 INFO - warning: no files found matching '*.txt' 11:48:18 INFO - no previously-included directories found matching 'build' 11:48:18 INFO - no previously-included directories found matching 'dist' 11:48:18 INFO - no previously-included directories found matching '.git*' 11:48:18 INFO - Successfully installed jsonschema functools32 11:48:18 INFO - Cleaning up... 11:48:18 INFO - Return code: 0 11:48:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:18 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')]} 11:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:18 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')]} 11:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:18 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:18 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 11:48:18 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 11:48:18 INFO - Using env: {'DISPLAY': ':0', 11:48:18 INFO - 'HOME': '/home/cltbld', 11:48:18 INFO - 'LANG': 'en_US.UTF-8', 11:48:18 INFO - 'LANGUAGE': 'en_US:en', 11:48:18 INFO - 'LOGNAME': 'cltbld', 11:48:18 INFO - 'MAIL': '/var/mail/cltbld', 11:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:18 INFO - 'MOZ_NO_REMOTE': '1', 11:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:18 INFO - 'NO_EM_RESTART': '1', 11:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:18 INFO - 'PWD': '/builds/slave/test', 11:48:18 INFO - 'SHELL': '/bin/bash', 11:48:18 INFO - 'SHLVL': '1', 11:48:18 INFO - 'TERM': 'linux', 11:48:18 INFO - 'TMOUT': '86400', 11:48:18 INFO - 'USER': 'cltbld', 11:48:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:18 INFO - '_': '/tools/buildbot/bin/python'} 11:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:20 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48:21 INFO - Downloading docopt-0.6.1.tar.gz 11:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:21 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:21 INFO - Running setup.py install for blobuploader 11:48:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:21 INFO - Running setup.py install for requests 11:48:21 INFO - Running setup.py install for docopt 11:48:21 INFO - Successfully installed blobuploader requests docopt 11:48:21 INFO - Cleaning up... 11:48:21 INFO - Return code: 0 11:48:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:21 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:21 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 11:48:21 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 11:48:21 INFO - Using env: {'DISPLAY': ':0', 11:48:21 INFO - 'HOME': '/home/cltbld', 11:48:21 INFO - 'LANG': 'en_US.UTF-8', 11:48:21 INFO - 'LANGUAGE': 'en_US:en', 11:48:21 INFO - 'LOGNAME': 'cltbld', 11:48:21 INFO - 'MAIL': '/var/mail/cltbld', 11:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:21 INFO - 'MOZ_NO_REMOTE': '1', 11:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:21 INFO - 'NO_EM_RESTART': '1', 11:48:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:21 INFO - 'PWD': '/builds/slave/test', 11:48:21 INFO - 'SHELL': '/bin/bash', 11:48:21 INFO - 'SHLVL': '1', 11:48:21 INFO - 'TERM': 'linux', 11:48:21 INFO - 'TMOUT': '86400', 11:48:21 INFO - 'USER': 'cltbld', 11:48:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:21 INFO - '_': '/tools/buildbot/bin/python'} 11:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:22 INFO - Running setup.py (path:/tmp/pip-GWonpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:22 INFO - Running setup.py (path:/tmp/pip-6b9AkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:22 INFO - Running setup.py (path:/tmp/pip-kSR3X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:22 INFO - Running setup.py (path:/tmp/pip-ZzHJ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:22 INFO - Running setup.py (path:/tmp/pip-k80kMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:22 INFO - Running setup.py (path:/tmp/pip-SwydxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:22 INFO - Running setup.py (path:/tmp/pip-7rTmeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:22 INFO - Running setup.py (path:/tmp/pip-xyM5eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:22 INFO - Running setup.py (path:/tmp/pip-CVtOdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:22 INFO - Running setup.py (path:/tmp/pip-AgKtme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:22 INFO - Running setup.py (path:/tmp/pip-ggy6hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:22 INFO - Running setup.py (path:/tmp/pip-GRshm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:23 INFO - Running setup.py (path:/tmp/pip-G7y0sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:23 INFO - Running setup.py (path:/tmp/pip-v_uacr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:23 INFO - Running setup.py (path:/tmp/pip-mVkpBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:23 INFO - Running setup.py (path:/tmp/pip-51roo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:23 INFO - Running setup.py (path:/tmp/pip-sLuIQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:23 INFO - Running setup.py install for manifestparser 11:48:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:23 INFO - Running setup.py install for mozcrash 11:48:23 INFO - Running setup.py install for mozdebug 11:48:23 INFO - Running setup.py install for mozdevice 11:48:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:23 INFO - Running setup.py install for mozfile 11:48:23 INFO - Running setup.py install for mozhttpd 11:48:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:23 INFO - Running setup.py install for mozinfo 11:48:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for mozInstall 11:48:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for mozleak 11:48:24 INFO - Running setup.py install for mozlog 11:48:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for moznetwork 11:48:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for mozprocess 11:48:24 INFO - Running setup.py install for mozprofile 11:48:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for mozrunner 11:48:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:24 INFO - Running setup.py install for mozscreenshot 11:48:24 INFO - Running setup.py install for moztest 11:48:25 INFO - Running setup.py install for mozversion 11:48:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:25 INFO - Cleaning up... 11:48:25 INFO - Return code: 0 11:48:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:25 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:25 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 11:48:25 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 11:48:25 INFO - Using env: {'DISPLAY': ':0', 11:48:25 INFO - 'HOME': '/home/cltbld', 11:48:25 INFO - 'LANG': 'en_US.UTF-8', 11:48:25 INFO - 'LANGUAGE': 'en_US:en', 11:48:25 INFO - 'LOGNAME': 'cltbld', 11:48:25 INFO - 'MAIL': '/var/mail/cltbld', 11:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:25 INFO - 'MOZ_NO_REMOTE': '1', 11:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:25 INFO - 'NO_EM_RESTART': '1', 11:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:25 INFO - 'PWD': '/builds/slave/test', 11:48:25 INFO - 'SHELL': '/bin/bash', 11:48:25 INFO - 'SHLVL': '1', 11:48:25 INFO - 'TERM': 'linux', 11:48:25 INFO - 'TMOUT': '86400', 11:48:25 INFO - 'USER': 'cltbld', 11:48:25 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:25 INFO - '_': '/tools/buildbot/bin/python'} 11:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:25 INFO - Running setup.py (path:/tmp/pip-EZvZTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:25 INFO - Running setup.py (path:/tmp/pip-nOE5cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:25 INFO - Running setup.py (path:/tmp/pip-hteL9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:25 INFO - Running setup.py (path:/tmp/pip-9EE1uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:25 INFO - Running setup.py (path:/tmp/pip-60br42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:25 INFO - Running setup.py (path:/tmp/pip-mR8UJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:25 INFO - Running setup.py (path:/tmp/pip-oFva2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:25 INFO - Running setup.py (path:/tmp/pip-kxO4Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:25 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)) 11:48:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:25 INFO - Running setup.py (path:/tmp/pip-700UW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:26 INFO - Running setup.py (path:/tmp/pip-p7ovug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:26 INFO - Running setup.py (path:/tmp/pip-z7yctY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:26 INFO - Running setup.py (path:/tmp/pip-kokmAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:26 INFO - Running setup.py (path:/tmp/pip-6t87Q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:26 INFO - Running setup.py (path:/tmp/pip-bprFUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:26 INFO - Running setup.py (path:/tmp/pip-qiCzuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:26 INFO - Running setup.py (path:/tmp/pip-EQgc6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:26 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)) 11:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:26 INFO - Running setup.py (path:/tmp/pip-RygZpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:26 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)) 11:48:26 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)) 11:48:26 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)) 11:48:26 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)) 11:48:26 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)) 11:48:26 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)) 11:48:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48:28 INFO - Downloading blessings-1.6.tar.gz 11:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:28 INFO - Installing collected packages: blessings 11:48:28 INFO - Running setup.py install for blessings 11:48:28 INFO - Successfully installed blessings 11:48:28 INFO - Cleaning up... 11:48:28 INFO - Return code: 0 11:48:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:29 INFO - Reading from file tmpfile_stdout 11:48:29 INFO - Current package versions: 11:48:29 INFO - argparse == 1.2.1 11:48:29 INFO - blessings == 1.6 11:48:29 INFO - blobuploader == 1.2.4 11:48:29 INFO - docopt == 0.6.1 11:48:29 INFO - functools32 == 3.2.3-2 11:48:29 INFO - jsonschema == 2.5.1 11:48:29 INFO - manifestparser == 1.1 11:48:29 INFO - mozInstall == 1.12 11:48:29 INFO - mozcrash == 0.17 11:48:29 INFO - mozdebug == 0.1 11:48:29 INFO - mozdevice == 0.48 11:48:29 INFO - mozfile == 1.2 11:48:29 INFO - mozhttpd == 0.7 11:48:29 INFO - mozinfo == 0.9 11:48:29 INFO - mozleak == 0.1 11:48:29 INFO - mozlog == 3.2 11:48:29 INFO - moznetwork == 0.27 11:48:29 INFO - mozprocess == 0.22 11:48:29 INFO - mozprofile == 0.28 11:48:29 INFO - mozrunner == 6.11 11:48:29 INFO - mozscreenshot == 0.1 11:48:29 INFO - mozsystemmonitor == 0.3 11:48:29 INFO - moztest == 0.7 11:48:29 INFO - mozversion == 1.4 11:48:29 INFO - psutil == 3.1.1 11:48:29 INFO - requests == 1.2.3 11:48:29 INFO - wsgiref == 0.1.2 11:48:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:29 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')]} 11:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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')]} 11:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:29 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 11:48:29 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 11:48:29 INFO - Using env: {'DISPLAY': ':0', 11:48:29 INFO - 'HOME': '/home/cltbld', 11:48:29 INFO - 'LANG': 'en_US.UTF-8', 11:48:29 INFO - 'LANGUAGE': 'en_US:en', 11:48:29 INFO - 'LOGNAME': 'cltbld', 11:48:29 INFO - 'MAIL': '/var/mail/cltbld', 11:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:29 INFO - 'MOZ_NO_REMOTE': '1', 11:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:29 INFO - 'NO_EM_RESTART': '1', 11:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:29 INFO - 'PWD': '/builds/slave/test', 11:48:29 INFO - 'SHELL': '/bin/bash', 11:48:29 INFO - 'SHLVL': '1', 11:48:29 INFO - 'TERM': 'linux', 11:48:29 INFO - 'TMOUT': '86400', 11:48:29 INFO - 'USER': 'cltbld', 11:48:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:29 INFO - '_': '/tools/buildbot/bin/python'} 11:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 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)) 11:48:29 INFO - Cleaning up... 11:48:29 INFO - Return code: 0 11:48:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:29 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')]} 11:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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')]} 11:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:29 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 11:48:29 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 11:48:29 INFO - Using env: {'DISPLAY': ':0', 11:48:29 INFO - 'HOME': '/home/cltbld', 11:48:29 INFO - 'LANG': 'en_US.UTF-8', 11:48:29 INFO - 'LANGUAGE': 'en_US:en', 11:48:29 INFO - 'LOGNAME': 'cltbld', 11:48:29 INFO - 'MAIL': '/var/mail/cltbld', 11:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:29 INFO - 'MOZ_NO_REMOTE': '1', 11:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:29 INFO - 'NO_EM_RESTART': '1', 11:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:29 INFO - 'PWD': '/builds/slave/test', 11:48:29 INFO - 'SHELL': '/bin/bash', 11:48:29 INFO - 'SHLVL': '1', 11:48:29 INFO - 'TERM': 'linux', 11:48:29 INFO - 'TMOUT': '86400', 11:48:29 INFO - 'USER': 'cltbld', 11:48:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:29 INFO - '_': '/tools/buildbot/bin/python'} 11:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:48:29 INFO - Cleaning up... 11:48:29 INFO - Return code: 0 11:48:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:48:29 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')]} 11:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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')]} 11:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:29 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 0x7f541d27af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cc190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', '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 11:48:29 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 11:48:29 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 11:48:29 INFO - Using env: {'DISPLAY': ':0', 11:48:29 INFO - 'HOME': '/home/cltbld', 11:48:29 INFO - 'LANG': 'en_US.UTF-8', 11:48:29 INFO - 'LANGUAGE': 'en_US:en', 11:48:29 INFO - 'LOGNAME': 'cltbld', 11:48:29 INFO - 'MAIL': '/var/mail/cltbld', 11:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:29 INFO - 'MOZ_NO_REMOTE': '1', 11:48:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:29 INFO - 'NO_EM_RESTART': '1', 11:48:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:29 INFO - 'PWD': '/builds/slave/test', 11:48:29 INFO - 'SHELL': '/bin/bash', 11:48:29 INFO - 'SHLVL': '1', 11:48:29 INFO - 'TERM': 'linux', 11:48:29 INFO - 'TMOUT': '86400', 11:48:29 INFO - 'USER': 'cltbld', 11:48:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:29 INFO - '_': '/tools/buildbot/bin/python'} 11:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:29 INFO - Downloading/unpacking flake8 11:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:48:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:48:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:31 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 11:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:48:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:32 INFO - no previously-included directories found matching 'docs/_build' 11:48:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:48:32 INFO - Running setup.py install for pep8 11:48:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:48:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:48:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:48:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:48:32 INFO - no previously-included directories found matching 'docs/_build' 11:48:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:48:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:48:32 INFO - Cleaning up... 11:48:32 INFO - Return code: 0 11:48:32 INFO - Running post-action listener: _resource_record_post_action 11:48:32 INFO - Running post-action listener: _start_resource_monitoring 11:48:32 INFO - Starting resource monitoring. 11:48:32 INFO - ##### 11:48:32 INFO - ##### Finished create-virtualenv step (success) 11:48:32 INFO - ##### 11:48:32 INFO - ##### 11:48:32 INFO - ##### Running install step. 11:48:32 INFO - ##### 11:48:32 INFO - Running pre-action listener: _resource_record_pre_action 11:48:32 INFO - Running main action method: install 11:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:32 INFO - Reading from file tmpfile_stdout 11:48:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:32 INFO - Reading from file tmpfile_stdout 11:48:32 INFO - Output received: 11:48:32 INFO - Usage: mozinstall [options] installer 11:48:32 INFO - Options: 11:48:32 INFO - -h, --help show this help message and exit 11:48:32 INFO - -d DEST, --destination=DEST 11:48:32 INFO - Directory to install application into. [default: 11:48:32 INFO - "/builds/slave/test"] 11:48:32 INFO - --app=APP Application being installed. [default: firefox] 11:48:32 INFO - mkdir: /builds/slave/test/build/application 11:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:48:49 INFO - Reading from file tmpfile_stdout 11:48:49 INFO - Output received: 11:48:49 INFO - /builds/slave/test/build/application/firefox/firefox 11:48:49 INFO - Running post-action listener: _resource_record_post_action 11:48:49 INFO - ##### 11:48:49 INFO - ##### Finished install step (success) 11:48:49 INFO - ##### 11:48:49 INFO - ##### 11:48:49 INFO - ##### Running run-tests step. 11:48:49 INFO - ##### 11:48:49 INFO - Running pre-action listener: _resource_record_pre_action 11:48:49 INFO - Running main action method: run_tests 11:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:49 INFO - Python 2.7.3 11:48:49 INFO - Return code: 0 11:48:49 INFO - grabbing minidump binary from tooltool 11:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:49 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 0x125e110>, '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 0x11ca230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ca6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:49 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 11:48:49 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 11:48:49 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 11:48:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:49 INFO - Return code: 0 11:48:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:48:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:48:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:48:50 INFO - Return code: 0 11:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 11:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 11:48:50 INFO - Using env: {'DISPLAY': ':0', 11:48:50 INFO - 'HOME': '/home/cltbld', 11:48:50 INFO - 'LANG': 'en_US.UTF-8', 11:48:50 INFO - 'LANGUAGE': 'en_US:en', 11:48:50 INFO - 'LOGNAME': 'cltbld', 11:48:50 INFO - 'MAIL': '/var/mail/cltbld', 11:48:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:50 INFO - 'MOZ_NO_REMOTE': '1', 11:48:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:50 INFO - 'NO_EM_RESTART': '1', 11:48:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:50 INFO - 'PWD': '/builds/slave/test', 11:48:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:50 INFO - 'SHELL': '/bin/bash', 11:48:50 INFO - 'SHLVL': '1', 11:48:50 INFO - 'TERM': 'linux', 11:48:50 INFO - 'TMOUT': '86400', 11:48:50 INFO - 'USER': 'cltbld', 11:48:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689', 11:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:50 INFO - '_': '/tools/buildbot/bin/python'} 11:48:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 11:48:50 INFO - mozversion application_buildid: 20160606083115 11:48:50 INFO - mozversion application_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:48:50 INFO - mozversion application_display_name: Nightly 11:48:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:50 INFO - mozversion application_name: Firefox 11:48:50 INFO - mozversion application_remotingname: firefox 11:48:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:48:50 INFO - mozversion application_vendor: Mozilla 11:48:50 INFO - mozversion application_version: 49.0a1 11:48:50 INFO - mozversion platform_buildid: 20160606083115 11:48:50 INFO - mozversion platform_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:48:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:48:50 INFO - mozversion platform_version: 49.0a1 11:48:50 INFO - using testdate: 1465238930 11:48:50 INFO - actual date: 1465238930 11:48:50 INFO - starting webserver on 'localhost:43217' 11:48:50 INFO - SUITE-START | Running 2 tests 11:48:50 INFO - TEST-START | dromaeo_css 11:48:50 INFO - operating with platform_type : linux_ 11:48:50 INFO - Initialising browser for dromaeo_css test... 11:48:50 INFO - TEST-INFO | started process 29364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMdsB9/profile http://localhost:43217/getInfo.html) 11:48:54 INFO - PROCESS | 29364 | __metrics Screen width/height:1600/1200 11:48:54 INFO - PROCESS | 29364 | colorDepth:24 11:48:54 INFO - PROCESS | 29364 | Browser inner width/height: 1024/697 11:48:54 INFO - PROCESS | 29364 | __metrics 11:48:55 ERROR - PROCESS | 29364 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 11:48:56 INFO - TEST-INFO | 29364: exit 0 11:48:56 INFO - Browser initialized. 11:48:56 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:56 INFO - TEST-INFO | started process 29484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMdsB9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:07 INFO - PROCESS | 29484 | RSS: Main: 167145472 11:49:07 INFO - PROCESS | 29484 | 11:49:57 INFO - PROCESS | 29484 | 1465238997563 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] 11:52:05 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43217/tests/dromaeo/cssquery-ext.html) 11:52:06 INFO - PROCESS | 29484 | RSS: Main: 170782720 11:52:06 INFO - PROCESS | 29484 | 11:55:08 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-ext.html (next: http://localhost:43217/tests/dromaeo/cssquery-jquery.html) 11:55:09 INFO - PROCESS | 29484 | RSS: Main: 169926656 11:55:09 INFO - PROCESS | 29484 | 11:58:11 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43217/tests/dromaeo/cssquery-mootools.html) 11:58:11 INFO - PROCESS | 29484 | RSS: Main: 171192320 11:58:11 INFO - PROCESS | 29484 | 12:01:13 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43217/tests/dromaeo/cssquery-prototype.html) 12:01:14 INFO - PROCESS | 29484 | RSS: Main: 168321024 12:01:14 INFO - PROCESS | 29484 | 12:04:16 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43217/tests/dromaeo/cssquery-yui.html) 12:04:17 INFO - PROCESS | 29484 | RSS: Main: 170532864 12:04:17 INFO - PROCESS | 29484 | 12:07:19 INFO - PROCESS | 29484 | Cycle 1(1): loaded http://localhost:43217/tests/dromaeo/cssquery-yui.html (next: http://localhost:43217/tests/dromaeo/cssquery-dojo.html) 12:07:20 INFO - PROCESS | 29484 | RSS: Main: 171388928 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | __start_tp_report 12:07:20 INFO - PROCESS | 29484 | _x_x_mozilla_page_load 12:07:20 INFO - PROCESS | 29484 | _x_x_mozilla_page_load_details 12:07:20 INFO - PROCESS | 29484 | |i|pagename|runs| 12:07:20 INFO - PROCESS | 29484 | |0;dojo.html;3101.6588175300717;3168.160437484066;3171.6035495563056;3180.7137357637807;3183.952240716388;5484.780608775649;5493.91759123613;5511.834644960652;5622.156676498527;5638.633488823224;5395.433479484646;5537.252470916425;5554.888902221964;5573.972130139354;5606.859828504289;4960.826371077013;5067.797288108472;5083.949160508385;5107.897842043157;5130.769115389817;4990.725510096943;5170.3020092287625;5177.48225177483;5202.531772140506;5206.140986737184;4999.700017998932;5021.447640759514;5041.991601679661;5055.646104772667;5083.288339632436;5060.974695126538;5079.288899554065;5089.287499750038;5107.897842043176;5109.029284435946;5060.696358218482;5071.264666623356;5081.720505372203;5086.720230387327;5112.642115051948;5401.297831281948;5422.132458806572;5459.454054594548;5504.80733174341;5550.139728342114;5902.203202567642;5937.732802023919;5938.910916336258;5950.315713692938;5972.70136493178;5714.714264286769;5982.132590774357;5994.550408719363;6007.3992600739575;6011.458968692838;5493.917591236134;5502.174673798922;5503.284573005523;5525.281713377275;5543.750531226065;6040.909386359208;6049.606775559574;6057.546188914629;6061.969690151521;6086.695665216722;5680.204771332017;5720.141978703228;5751.194832723422;5824.213731146326;5851.736671849777;5868.941310586925;5872.060470324727;5896.439838215363;5938.703064846741;5950.2264705587995;5746.281714785652;5867.6772777497645;5876.794312199053;5898.498627616615;5915.40845915405;5869.148973398833;5882.617629854046;5942.1978032965;5942.1978032965;5942.8811423771285;4370.978145109254;4435.800388982503;4474.463064432289;4511.503734589192;4513.887152821206;3996.440498330236;3997.380406037069;4004.6596039336982;4037.0714735610973;4044;5472.398036216013;5736.110902810071;5747.942520574741;5754.367019627837;5771.105478650816;5798.304203495608;5817.563682723812;5853.824385268449;5880.176775251468;5905.527557795366;5576.414476479911;5597.076482380443;5607.467290607386;5613.46672066153;5631.71841407928;4959.553640172402;5032.597392208614;5038.647294689336;5076.213186956028;5077.771500282496;6094.451499365078;6204.162438070893;6209.348018457997;6212;6215.782447614311;6005.849853753691;6017.2779266488305;6018.337982821974;6036.732286219943;6062.666553339609;5874.530037597067;6023.5181185505935;6111.266648002268;6155.415235552616;6175.289841668086;5885;5885.646861188342;5888.970555147368;5901.468867801918;5934.614250073904;5927.85180370477;5983.252093488314;5995.250593675791;6000.5799594028;6002.399760024137;5649.802256920988;5742.827715168552;5776.826695199151;5793.884122317614;5851.970740146272;5530.142827861688;5679.858003549944;5707.971460142673;5767.480926716616;5776.508996735324;5678.4605462480995;5693.089105743061;5717.828465146053;5718.1708652246025;5732.856678582902;5609.102543593006;5799.942000580109;5808.012637851491;5840;5855.238818953509;5718.170865224436;5739.282589676291;5776.364599894092;5777.162311464898;5816.156657284585 12:07:20 INFO - PROCESS | 29484 | |1;ext.html;575.9164921086442;600.4175949329152;621.0714981103251;643.1767337807605;652.6116960408556;38346.616533834655;42973.140537189276;43113.35329970049;43357.7832110839;43540.564594354044;44249;44452.777736111275;44541.331880021746;44542.55457445425;44949;8670.956645216766;8843.690470833522;8864.468131912074;8864.556772161366;8867.467951922874;8557.48655080697;8580.056193818675;8582.313414926792;8607.6126574304;8621.13788621139;8533.232009119178;8600.35497337699;8603.268722158624;8621.180987806149;8663.870041949376;8635.481871087723;8648.697295594624;8650.178233067849;8654.177853103914;8659.783505412384;8690.826183476294;8754.86867696985;8789.912100879037;8790.252828509585;8800.779980500538;31989.360212795615;40089;40845.59154408448;40925.795371023254;41097.58902410968;3382.678645528671;3411.4371128763723;3548.0420286522494;3672.779633222015;4157.355609880443;30408.54387184194;30445.391092178033;31057.844710776528;31087;31297.374052518822;4149.107941792529;4161.25097482453;4250.574942505756;4279.572042795727;4410.691251612388;302067.9999999978;303552;304130;304731;305511;35014.64985350165;35052.12369690778;35133.297334053175;35137.824310878284;35228.47157292643;35623.64376356255;35799.64200358015;35960.64039359625;35998.64001359953;36029.459558106646;15483.374245704264;15533.223338833013;15546.9222653886;15618.609534761494;15634.140122293156;13142.868571314164;13149.145305555108;13242.668933276746;13312.800307995389;13355.465781368637;7916.643751031217;8121.4721043132;8127.3904457165945;8193;8208.917910820936;3188.4739018062223;3228.5157226416227;3233.9949231476166;3241.821699806533;3300.4389253826425;1094.2395035450445;1097.1277834121893;1191.0888170549536;1193.8507686539183;1216.403962058585;33183.502247466306;33496.66503334935;33541.161470962936;33576.328473430396;34305.82847085749;1136.8976792088586;1139.9088072954144;1192.9582464613698;1251.5556977272936;1304.1197191895621;16510.83489165117;16784;16795.004787743415;16805.663886722195;16887.493375198763;578384;587779;588308;588369;593558;57018.42981570131;57070;57460.712696437084;57616.13575796366;57624.42375576274;1375.3810785146525;1396.5670642100981;1406.8593140686055;1410.5204230561658;1433.2618701368804;30068.24829379283;31142;31224.21939451532;31648.525272120474;32196.35607287888;48439.51560484491;48735.512644874514;48896.26655600098;49483.50516494789;49527.25709114294;511271;512565;513723;515941.2608810946;517793;25931;26017.47965040651;26180.607290891032;26209.213723588324;27707.168784936483;47591.524084760094;47851.5214847861;48070.519294808;48355.758221210075;48769.51230487791;40386.39420408755;40741.59258407378;40997.38503922384;41181.794091029355;41344.586554134075;40373.394399084624;40560.39159412552;41013.79493102516;41022.38466422947;41490.170196596504;35265.82367088148;40461;40519.1896162081;40931;41824;34675;36076.27847443089;36464.27071458609;36665.81667091647;36701.26597468089;27825.16524504268;27976.300592484535;28170.43659126847;28470.145895623165;28552.857235713687 12:07:20 INFO - PROCESS | 29484 | |2;jquery.html;382.37290843017445;385.6606186555831;388.90860647747775;396.90474286171326;412.8843923701365;14203.360848761804;18103;19081.236750529963;19539.706904396444;19664.115114819833;18426.44720658379;18683.71974420385;19008.334708285212;19159.137838797255;19193;5672.659640421567;5709.086546152616;5855.385184555625;5858.824235272928;5927.792527261547;5229.137192363255;5516.613837031409;5690.260266165393;5749.59752817303;5797.826065218029;5499.3675727291475;5521.061419558665;5532.170174473841;5574.637648552852;5591.860203494904;5645.633033852807;6189.9381006189815;6201.844953876144;6214.5960512566535;6217.751289948396;5402.837914862561;5412.512873841334;5655.208270842086;5683.460071293221;5692.9146062809095;13621.795673064911;13803.930980345134;13842.446302147902;20510.38468845937;22556;2185.7704940981284;2195.829510798142;2204.4268490192503;2245.887705614729;2531.153811672595;10304;10437.478126093665;10520.158387329071;10666.679999599946;10741.677749667522;1919.280269898788;1972.5167334003118;2011.4870707969374;2047.4369548374168;2065.2565076572423;66484;66624;74523;75691.62154189193;85669.57165214197;10777.62278320255;10966.187175473964;10988.285761425483;11022.50398732059;11023;15287.464938727091;15308.234588270541;15421.614459638598;15477.9226103871;15527.689446211012;7645.235476452422;7943.602819859099;8243.299319557906;8290.751277461686;8604.397692161489;7425.405967522585;7631.885521717179;7654.578998155043;7786.065672119382;7958.562279074591;4652.97673511637;4714.269288260325;4789.413716593071;4838.129136755418;4850.272459131159;1957.3736404350757;1961.8724782889067;1962.1268535501565;1964.361582485698;1993.312307253995;874.4665753890122;927.590063104078;1032.390889375272;1077.1921059205595;1094.7044298039484;19016.334428294944;19074.713879291823;19215.423537293904;19549.8186686383;19611.901940490206;976.4678250353575;998.9550470228858;1015.7663737340453;1017.3133135133903;1020.2195320579763;10280.331778434378;10717.785644287227;10731.678049658523;10735.141188704885;10757.623483178208;168780;169645;169861;170556;170644;91404;97033.5148324268;98403;98575.50712246537;98814.50592747134;989.2135752077116;1010.6109147977934;1016.0499932563077;1030.294248439821;1030.6753372687579;16842.831571684615;17141.400050998156;17236.138193090046;17245.310187592357;17643.382481613597;41224.175516488904;41568.376474352306;41718;42318.36522452104;43045.56954430541;54848.45151548433;57677.71161144167;66205;66263;66524.33475665376;5964.731587078505;8009.359251260002;8321.167883211872;8462.11147829469;8647.221750042274;12061.819072714092;12644.620661380173;12711.237325760483;12848.229106253655;13314.600561983156;11085.667429977113;11239.157063220455;11294.887051129384;11516.827247591125;11584.652460426201;9065.954670226607;11058.11535077208;11098.667039988813;11236.325820450798;11453.427328633701;11221.66335009951;11402.486888090221;11514.654560363202;11657.766844663229;12143;8358.749237522885;8485.193906578865;8504.91495085066;8605.139486051345;8693.26107280863;10468.895311047097;11057.11543076568;11133.443327833738;11195.776084478102;11572.884271157518 12:07:20 INFO - PROCESS | 29484 | |3;mootools.html;1451.6733734909653;1506.2167672810135;1532.4559781277644;1675.7570152327912;1853.5829438376368;7758.185390533998;8544.786380340487;8597.226249637532;9055;9078.137576930198;8741.95629021854;8755.562221888911;8806.339524535653;8832.955835220815;8849.336299777526;2304.608216603173;2328.359701082199;2330.254318618043;2335.614623587106;2347.753485883983;2264.2188444986455;2277.1346888182466;2329.9534009319887;2335.2060299498166;2335.369450248432;2262.5474905018978;2288.1762565476415;2304.1129165271323;2340.6137987232087;2343.5078633486987;2235.519363336882;2239.5520895820737;2240.932772016842;2241.1035585765662;2251.279590531031;2099.88450635215;2104.6106470303043;2106.8735875847497;2116.9259075932423;2119.8198153157;8823.250023747989;8921.687740929035;8936.508492032935;8949.731508054703;8951.373403861733;4990.975045124787;5017.67385119966;5036.445990940993;5074.035933172685;5083.212102124176;3279.7212236959886;3385.5091011803397;3555.0756803231347;3562.7684200526883;3569.1969306906;1258.6916205529703;1263.5261776833688;1266.7593157300084;1281.7564662714055;2166.350094971518;12377;12615.243085414904;12708.301043442607;12771.808422873664;12784.936075319656;4456.6211871991245;4521.638268938543;4536.387587675622;4557.794899229476;4596.609288210473;9890.950545247371;9909.504524773733;9959.751006224757;9966.053224943618;9978.201743860618;5223.582113430916;5224.92162617561;5229.032628963654;5234.685918844882;5246.606504512177;4223.1975924574235;4712.9057418851435;4856.732879691651;4862.17343051682;4900.583450406755;3748.11919198988;3752.9061773455883;3776.735628506033;3847.2305538892333;3902.2585708715255;1109.2401704832216;1123.9044681202026;1124.8706398764084;1140.5095808802296;1141.5262665993687;858.8582883824099;1002.7242508310127;1003.307717674802;1006.4716024087413;1025.9794804103876;6157.6613286269685;6186.81439556814;6235.968820155961;6253.437190652863;6295;454.7680682851769;460.4635599526514;463.2425983516907;466.6709969471514;469.71816909853817;4160.854370097032;4261.488621365394;4302.892427689333;4376.584224498668;4379.58393952574;10822.242443028912;11219.270747401557;11281.32312061279;11347;11362.659120226406;11088.390138542296;11157.107431405468;11197.72005699864;11211.831822522669;11230.775384492428;8068;8379.58102094905;8386.203310685476;8388.706395276258;8577.614007369559;6161.44546990773;6209.59637623553;6292.276388215414;6396.26442959047;6415.230172379344;10308.742281443025;10495.265331426726;10591.099756520782;10694.518746656575;10697.786044279226;10737.516811743333;10776.892231077589;10867.51096200657;10889.891101088888;10891.509882055168;7830.412719046209;7956.92043079585;7974.202579741979;8009.919900800917;8179.509229446252;8579.528125953133;8603.784905377415;8620.61207245663;8648.394612377073;8678.783030424038;7497.175310715926;7639.236076392316;7754.030746156731;7807.843843122992;7832.37341012729;7558.093028836355;7676.501027433199;7678.308952194329;7770.728024519115;7785.104712957856;6968.65156742171;6979.8604027918145;7019.789406317818;7023.683934223074;7029.051078104595;4877.682950608341;4883.804647814048;4974.204127339608;5052.343195384577;5057.418396884405;4935.531124543163;4966.205407134841;4971.925421118758;4994.9500504994485;5090.338256026693 12:07:20 INFO - PROCESS | 29484 | |4;prototype.html;326.8627176585834;332.775376620781;341.5935037305606;343.52936477026475;346.4318517631084;5639.830805075844;5669.631473954195;5680.579855036241;5702.686352250625;5736.741846616902;5568.5266752326;5596.776128954847;5626.943730562693;5627.774889004435;5660.773569057233;4158.8978920586;4199.2441360555085;4344.9348259776125;4350.847720329789;4360.23695853226;4334.869953901388;4341.934870976938;4344.783460631028;4376.671749618776;4385.298352263639;4335.414719012941;4336.718113322624;4343.739375637456;4345.652347812167;4349.347597860315;4274.123804620045;4309.504406993205;4309.762963037032;4319.0713996490595;4334.588214119638;3800.8669696560764;3804.8287827047848;3818.5417749869916;3836.5204349456317;3842.9807850960847;5394.7842086316505;5410.215518749798;5410.592286432539;5428.88707814897;5461.972690136564;4892.363992680965;4930.383702037246;5034.874128146789;5041.873953151164;5070.543651071384;5733.827985160452;5778.768849246025;5781.913271300934;5848.385919478436;5864.70676466175;4271.97864010681;4275.935860962088;4281.100968796556;4283.850065247732;4287.335463003239;5769.221155144044;6053.424924632153;6053.878922421527;6070.817875463699;6156.96921515394;4269.316909294498;4270.846871344719;4283.914321713548;4296.2911119664905;4307.956920430755;4343.82624695015;4351.303791393362;4361.934570981438;4363.6072753452345;4374.58441448062;4831.178699621073;4956.132676781549;4968;4972.154733695281;5010.173321401928;5774.769009239667;5789.8552536186935;5862.710203755167;5912.497437717756;5925.40745925404;1488.761798112297;1501.6996600679909;1509.8565636264536;1510.1316742872891;1511.8790496760232;958.9328746987644;965.5461932891529;1018.5162048027128;1020.505055048301;1030.1141018723893;5648.6443253619655;5701.258836351248;5716.485516303553;5735.741891614887;5783.537317014629;6033.607815492067;6089.512838972872;6098.231512861309;6105.725242364104;6106.084087386838;5501.284832971688;5652;5668.914966275509;5747.942520574741;5750;3192.4892017277125;3204.6955539223736;3227.0964130043626;3227.177069847174;3245.594300712411;5957.910631340534;6145.661988590581;6191.133241346215;6192.318844927055;6207.255129384503;6038.18484504595;6053.122297266872;6087.6956152192215;6109.236345456818;6122.418370254819;5759.481646651905;6188.391018335175;6210.795167715396;6241.78153764616;6248.4064013918605;5923.674197919156;5924.052151655715;5996.5502587305255;6015.578909476295;6030.969845150922;5930.703464826827;5973.761049557969;5976.61152025117;5978.701064946822;5984.700764961822;5952.769615844984;6170.290416602148;6208.596441231305;6229.719662615103;6237.313895471585;4258.339957306623;4264.5309016007595;4275.315949448198;4277.443932288783;4296.548862369406;5819.825405237681;5879.147523609138;6020.668863212565;6071.726772295346;6082.665453399928;5787.334456537384;5906.527477801679;5908.96593096215;5939.138824870283;5965.492933100735;5701.945140149086;5916.822495325147;5922.2597175353085;5935.7032148391545;5958.19564358806;5733.3406658234835;5764.308283006066;5775.711214439178;5808.94191058084;5831.504322132497;5944.910826337695;5948;5952.464278214981;5958.19564358806;5979.521638269015;5613.4282400927805;5735.627184233012;5808.5353171747;5821.79623713168;5828.271466066742 12:07:20 INFO - PROCESS | 29484 | |5;yui.html;733.9633018349084;774.868272393693;827.5034979012593;844.8437039147755;862.4264863865529;14540.345684444199;15382.769258461118;15560.53318400447;15601.375944962188;15651.060936343813;14731.558053258419;14865.182414967172;14905.32926018329;14917.403303867832;14977.101373917545;663.1776597019697;782.4679218131669;803.2128514056228;810.432697112021;819.3690858039306;796.3231253434564;805.3396215103618;810.8905297784812;811.5658122904248;814.9307308878753;852.5438890193748;855.9229669329759;856.5888373580685;858.0347109501811;864.8962124545063;853.8463076646201;858.103282070235;858.5750053723447;858.8196478739472;859.8667206582959;618.0358640520757;620.7020630097534;627.316225314405;627.6359711367396;627.9811605651838;15156.848431515655;15243.237838108162;15250.161241131733;15264.38942442301;15313.693726125526;15285.770713439308;15403.3838646454;15560.688786224213;15575.143367114804;15576.299066542033;12584.68538286541;12622.936885315607;12729.554465593752;12801.359932003363;12916.41876115577;3934.3705007198996;3957.1096503286817;3973.264945985002;4004.659603933669;4115.42384066231;74113;74200.62899685522;74286.25713742847;75688;78248.21751782524;11814.88185118155;11972.461239244254;12084.939575302067;12122.75754484923;12334.568290109803;20691.275805347042;20784.896075519526;20808.58382832335;20836.27073052436;20843.895780521;8200.794980125545;8268.875966860502;8351.415400921876;8540.572971351532;8755.605997730117;4732.621390288768;4764.2615394613895;4852.2479015752615;4854.75726213695;4903.338049363361;3590.2998915211806;3715.8327875245136;3725.3666876631037;3726.5155529780955;3735.1035751419463;640.4492136762381;646.7542333913083;650.5803756576981;654.4764188649061;672.7847088931495;716.9962053125562;733.3802936518633;751.1244600365167;760.5777196642314;784.1491981200461;10098.343607665625;10492.527836247387;10518.211134164969;10530.684079477627;10601.204909631808;610.4201009041428;669.4276393683331;745.4632664481564;785.7053604898164;787.1656044592636;4545.795439205243;4594.310853372021;4627;4747.406574178228;4754.5007774183905;112641;113609;114974.42512787382;116608.41695791636;119544;91857;93545.5322723382;95979.52010240043;98400;98846.5057674707;88509;89756.5512172435;90266.09733902708;91050.54474727584;91602;9459.621615135318;9464.574094165917;9644.373115747454;9700.175485083564;9775.902240977499;46840;52028.739856300475;52220.73889630527;52932.73533632307;52956.47043529515;68119.65940170268;68415.65792171007;78568.60715696384;80055.59972200335;80869.59565202137;12770.61688149357;12849;12907.354632268161;13088.541901033419;13094.345282735634;13534.255615941218;13614.795778063535;13772.24252666073;13956.232407217294;14377.209253491159;12857.164284321489;13329.200247985153;13361.732765344834;13383.063185577306;13717;12900.225986440844;13139.934300328438;13203.867961320264;13263.602091937257;13299.734005320033;12541.74916501683;12565;12580.288814799473;12617.315931055316;12793.616191513896;10400.167986560906;10805.405702686428;11034.889651103385;11116.333020018501;11306.94346528262;10960.835587466354;10995.945020274847;11129.833052504056;11135.164862635173;11169.609063682732 12:07:20 INFO - PROCESS | 29484 | __end_tp_report 12:07:20 INFO - PROCESS | 29484 | __start_cc_report 12:07:20 INFO - PROCESS | 29484 | _x_x_mozilla_cycle_collect,353 12:07:20 INFO - PROCESS | 29484 | __end_cc_report 12:07:20 INFO - PROCESS | 29484 | __startTimestamp1465240040121__endTimestamp 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | ------- Summary: start ------- 12:07:20 INFO - PROCESS | 29484 | Number of tests: 6 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#0] dojo.html Cycles:165 Average:5502.74 Median:5718.17 stddev:632.36 (11.1%) stddev-sans-first:605.60 12:07:20 INFO - PROCESS | 29484 | Values: 3101.7 3168.2 3171.6 3180.7 3184.0 5484.8 5493.9 5511.8 5622.2 5638.6 5395.4 5537.3 5554.9 5574.0 5606.9 4960.8 5067.8 5083.9 5107.9 5130.8 4990.7 5170.3 5177.5 5202.5 5206.1 4999.7 5021.4 5042.0 5055.6 5083.3 5061.0 5079.3 5089.3 5107.9 5109.0 5060.7 5071.3 5081.7 5086.7 5112.6 5401.3 5422.1 5459.5 5504.8 5550.1 5902.2 5937.7 5938.9 5950.3 5972.7 5714.7 5982.1 5994.6 6007.4 6011.5 5493.9 5502.2 5503.3 5525.3 5543.8 6040.9 6049.6 6057.5 6062.0 6086.7 5680.2 5720.1 5751.2 5824.2 5851.7 5868.9 5872.1 5896.4 5938.7 5950.2 5746.3 5867.7 5876.8 5898.5 5915.4 5869.1 5882.6 5942.2 5942.2 5942.9 4371.0 4435.8 4474.5 4511.5 4513.9 3996.4 3997.4 4004.7 4037.1 4044.0 5472.4 5736.1 5747.9 5754.4 5771.1 5798.3 5817.6 5853.8 5880.2 5905.5 5576.4 5597.1 5607.5 5613.5 5631.7 4959.6 5032.6 5038.6 5076.2 5077.8 6094.5 6204.2 6209.3 6212.0 6215.8 6005.8 6017.3 6018.3 6036.7 6062.7 5874.5 6023.5 6111.3 6155.4 6175.3 5885.0 5885.6 5889.0 5901.5 5934.6 5927.9 5983.3 5995.3 6000.6 6002.4 5649.8 5742.8 5776.8 5793.9 5852.0 5530.1 5679.9 5708.0 5767.5 5776.5 5678.5 5693.1 5717.8 5718.2 5732.9 5609.1 5799.9 5808.0 5840.0 5855.2 5718.2 5739.3 5776.4 5777.2 5816.2 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#1] ext.html Cycles:180 Average:60487.10 Median:40490.09 stddev:129234.29 (319.2%) stddev-sans-first:129518.54 12:07:20 INFO - PROCESS | 29484 | Values: 575.9 600.4 621.1 643.2 652.6 38346.6 42973.1 43113.4 43357.8 43540.6 44249.0 44452.8 44541.3 44542.6 44949.0 8671.0 8843.7 8864.5 8864.6 8867.5 8557.5 8580.1 8582.3 8607.6 8621.1 8533.2 8600.4 8603.3 8621.2 8663.9 8635.5 8648.7 8650.2 8654.2 8659.8 8690.8 8754.9 8789.9 8790.3 8800.8 31989.4 40089.0 40845.6 40925.8 41097.6 3382.7 3411.4 3548.0 3672.8 4157.4 30408.5 30445.4 31057.8 31087.0 31297.4 4149.1 4161.3 4250.6 4279.6 4410.7 302068.0 303552.0 304130.0 304731.0 305511.0 35014.6 35052.1 35133.3 35137.8 35228.5 35623.6 35799.6 35960.6 35998.6 36029.5 15483.4 15533.2 15546.9 15618.6 15634.1 13142.9 13149.1 13242.7 13312.8 13355.5 7916.6 8121.5 8127.4 8193.0 8208.9 3188.5 3228.5 3234.0 3241.8 3300.4 1094.2 1097.1 1191.1 1193.9 1216.4 33183.5 33496.7 33541.2 33576.3 34305.8 1136.9 1139.9 1193.0 1251.6 1304.1 16510.8 16784.0 16795.0 16805.7 16887.5 578384.0 587779.0 588308.0 588369.0 593558.0 57018.4 57070.0 57460.7 57616.1 57624.4 1375.4 1396.6 1406.9 1410.5 1433.3 30068.2 31142.0 31224.2 31648.5 32196.4 48439.5 48735.5 48896.3 49483.5 49527.3 511271.0 512565.0 513723.0 515941.3 517793.0 25931.0 26017.5 26180.6 26209.2 27707.2 47591.5 47851.5 48070.5 48355.8 48769.5 40386.4 40741.6 40997.4 41181.8 41344.6 40373.4 40560.4 41013.8 41022.4 41490.2 35265.8 40461.0 40519.2 40931.0 41824.0 34675.0 36076.3 36464.3 36665.8 36701.3 27825.2 27976.3 28170.4 28470.1 28552.9 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#2] jquery.html Cycles:180 Average:19876.51 Median:11278.91 stddev:32820.93 (291.0%) stddev-sans-first:32880.36 12:07:20 INFO - PROCESS | 29484 | Values: 382.4 385.7 388.9 396.9 412.9 14203.4 18103.0 19081.2 19539.7 19664.1 18426.4 18683.7 19008.3 19159.1 19193.0 5672.7 5709.1 5855.4 5858.8 5927.8 5229.1 5516.6 5690.3 5749.6 5797.8 5499.4 5521.1 5532.2 5574.6 5591.9 5645.6 6189.9 6201.8 6214.6 6217.8 5402.8 5412.5 5655.2 5683.5 5692.9 13621.8 13803.9 13842.4 20510.4 22556.0 2185.8 2195.8 2204.4 2245.9 2531.2 10304.0 10437.5 10520.2 10666.7 10741.7 1919.3 1972.5 2011.5 2047.4 2065.3 66484.0 66624.0 74523.0 75691.6 85669.6 10777.6 10966.2 10988.3 11022.5 11023.0 15287.5 15308.2 15421.6 15477.9 15527.7 7645.2 7943.6 8243.3 8290.8 8604.4 7425.4 7631.9 7654.6 7786.1 7958.6 4653.0 4714.3 4789.4 4838.1 4850.3 1957.4 1961.9 1962.1 1964.4 1993.3 874.5 927.6 1032.4 1077.2 1094.7 19016.3 19074.7 19215.4 19549.8 19611.9 976.5 999.0 1015.8 1017.3 1020.2 10280.3 10717.8 10731.7 10735.1 10757.6 168780.0 169645.0 169861.0 170556.0 170644.0 91404.0 97033.5 98403.0 98575.5 98814.5 989.2 1010.6 1016.0 1030.3 1030.7 16842.8 17141.4 17236.1 17245.3 17643.4 41224.2 41568.4 41718.0 42318.4 43045.6 54848.5 57677.7 66205.0 66263.0 66524.3 5964.7 8009.4 8321.2 8462.1 8647.2 12061.8 12644.6 12711.2 12848.2 13314.6 11085.7 11239.2 11294.9 11516.8 11584.7 9066.0 11058.1 11098.7 11236.3 11453.4 11221.7 11402.5 11514.7 11657.8 12143.0 8358.7 8485.2 8504.9 8605.1 8693.3 10468.9 11057.1 11133.4 11195.8 11572.9 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#3] mootools.html Cycles:180 Average:5848.80 Median:2528.54 stddev:3405.90 (134.7%) stddev-sans-first:3399.43 12:07:20 INFO - PROCESS | 29484 | Values: 1451.7 1506.2 1532.5 1675.8 1853.6 7758.2 8544.8 8597.2 9055.0 9078.1 8742.0 8755.6 8806.3 8833.0 8849.3 2304.6 2328.4 2330.3 2335.6 2347.8 2264.2 2277.1 2330.0 2335.2 2335.4 2262.5 2288.2 2304.1 2340.6 2343.5 2235.5 2239.6 2240.9 2241.1 2251.3 2099.9 2104.6 2106.9 2116.9 2119.8 8823.3 8921.7 8936.5 8949.7 8951.4 4991.0 5017.7 5036.4 5074.0 5083.2 3279.7 3385.5 3555.1 3562.8 3569.2 1258.7 1263.5 1266.8 1281.8 2166.4 12377.0 12615.2 12708.3 12771.8 12784.9 4456.6 4521.6 4536.4 4557.8 4596.6 9891.0 9909.5 9959.8 9966.1 9978.2 5223.6 5224.9 5229.0 5234.7 5246.6 4223.2 4712.9 4856.7 4862.2 4900.6 3748.1 3752.9 3776.7 3847.2 3902.3 1109.2 1123.9 1124.9 1140.5 1141.5 858.9 1002.7 1003.3 1006.5 1026.0 6157.7 6186.8 6236.0 6253.4 6295.0 454.8 460.5 463.2 466.7 469.7 4160.9 4261.5 4302.9 4376.6 4379.6 10822.2 11219.3 11281.3 11347.0 11362.7 11088.4 11157.1 11197.7 11211.8 11230.8 8068.0 8379.6 8386.2 8388.7 8577.6 6161.4 6209.6 6292.3 6396.3 6415.2 10308.7 10495.3 10591.1 10694.5 10697.8 10737.5 10776.9 10867.5 10889.9 10891.5 7830.4 7956.9 7974.2 8009.9 8179.5 8579.5 8603.8 8620.6 8648.4 8678.8 7497.2 7639.2 7754.0 7807.8 7832.4 7558.1 7676.5 7678.3 7770.7 7785.1 6968.7 6979.9 7019.8 7023.7 7029.1 4877.7 4883.8 4974.2 5052.3 5057.4 4935.5 4966.2 4971.9 4995.0 5090.3 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#4] prototype.html Cycles:180 Average:4941.72 Median:5690.92 stddev:1452.89 (25.5%) stddev-sans-first:1415.08 12:07:20 INFO - PROCESS | 29484 | Values: 326.9 332.8 341.6 343.5 346.4 5639.8 5669.6 5680.6 5702.7 5736.7 5568.5 5596.8 5626.9 5627.8 5660.8 4158.9 4199.2 4344.9 4350.8 4360.2 4334.9 4341.9 4344.8 4376.7 4385.3 4335.4 4336.7 4343.7 4345.7 4349.3 4274.1 4309.5 4309.8 4319.1 4334.6 3800.9 3804.8 3818.5 3836.5 3843.0 5394.8 5410.2 5410.6 5428.9 5462.0 4892.4 4930.4 5034.9 5041.9 5070.5 5733.8 5778.8 5781.9 5848.4 5864.7 4272.0 4275.9 4281.1 4283.9 4287.3 5769.2 6053.4 6053.9 6070.8 6157.0 4269.3 4270.8 4283.9 4296.3 4308.0 4343.8 4351.3 4361.9 4363.6 4374.6 4831.2 4956.1 4968.0 4972.2 5010.2 5774.8 5789.9 5862.7 5912.5 5925.4 1488.8 1501.7 1509.9 1510.1 1511.9 958.9 965.5 1018.5 1020.5 1030.1 5648.6 5701.3 5716.5 5735.7 5783.5 6033.6 6089.5 6098.2 6105.7 6106.1 5501.3 5652.0 5668.9 5747.9 5750.0 3192.5 3204.7 3227.1 3227.2 3245.6 5957.9 6145.7 6191.1 6192.3 6207.3 6038.2 6053.1 6087.7 6109.2 6122.4 5759.5 6188.4 6210.8 6241.8 6248.4 5923.7 5924.1 5996.6 6015.6 6031.0 5930.7 5973.8 5976.6 5978.7 5984.7 5952.8 6170.3 6208.6 6229.7 6237.3 4258.3 4264.5 4275.3 4277.4 4296.5 5819.8 5879.1 6020.7 6071.7 6082.7 5787.3 5906.5 5909.0 5939.1 5965.5 5701.9 5916.8 5922.3 5935.7 5958.2 5733.3 5764.3 5775.7 5808.9 5831.5 5944.9 5948.0 5952.5 5958.2 5979.5 5613.4 5735.6 5808.5 5821.8 5828.3 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - PROCESS | 29484 | [#5] yui.html Cycles:180 Average:20841.92 Median:4570.05 stddev:29972.05 (655.8%) stddev-sans-first:30018.10 12:07:20 INFO - PROCESS | 29484 | Values: 734.0 774.9 827.5 844.8 862.4 14540.3 15382.8 15560.5 15601.4 15651.1 14731.6 14865.2 14905.3 14917.4 14977.1 663.2 782.5 803.2 810.4 819.4 796.3 805.3 810.9 811.6 814.9 852.5 855.9 856.6 858.0 864.9 853.8 858.1 858.6 858.8 859.9 618.0 620.7 627.3 627.6 628.0 15156.8 15243.2 15250.2 15264.4 15313.7 15285.8 15403.4 15560.7 15575.1 15576.3 12584.7 12622.9 12729.6 12801.4 12916.4 3934.4 3957.1 3973.3 4004.7 4115.4 74113.0 74200.6 74286.3 75688.0 78248.2 11814.9 11972.5 12084.9 12122.8 12334.6 20691.3 20784.9 20808.6 20836.3 20843.9 8200.8 8268.9 8351.4 8540.6 8755.6 4732.6 4764.3 4852.2 4854.8 4903.3 3590.3 3715.8 3725.4 3726.5 3735.1 640.4 646.8 650.6 654.5 672.8 717.0 733.4 751.1 760.6 784.1 10098.3 10492.5 10518.2 10530.7 10601.2 610.4 669.4 745.5 785.7 787.2 4545.8 4594.3 4627.0 4747.4 4754.5 112641.0 113609.0 114974.4 116608.4 119544.0 91857.0 93545.5 95979.5 98400.0 98846.5 88509.0 89756.6 90266.1 91050.5 91602.0 9459.6 9464.6 9644.4 9700.2 9775.9 46840.0 52028.7 52220.7 52932.7 52956.5 68119.7 68415.7 78568.6 80055.6 80869.6 12770.6 12849.0 12907.4 13088.5 13094.3 13534.3 13614.8 13772.2 13956.2 14377.2 12857.2 13329.2 13361.7 13383.1 13717.0 12900.2 13139.9 13203.9 13263.6 13299.7 12541.7 12565.0 12580.3 12617.3 12793.6 10400.2 10805.4 11034.9 11116.3 11306.9 10960.8 10995.9 11129.8 11135.2 11169.6 12:07:20 INFO - PROCESS | 29484 | -------- Summary: end -------- 12:07:20 INFO - PROCESS | 29484 | 12:07:20 INFO - TEST-INFO | 29484: exit 0 12:07:20 INFO - TEST-OK | dromaeo_css | took 1109962ms 12:07:20 INFO - TEST-START | kraken 12:07:20 INFO - operating with platform_type : linux_ 12:07:20 INFO - Initialising browser for kraken test... 12:07:20 INFO - TEST-INFO | started process 29716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbOcuR/profile http://localhost:43217/getInfo.html) 12:07:24 INFO - PROCESS | 29716 | __metrics Screen width/height:1600/1200 12:07:24 INFO - PROCESS | 29716 | colorDepth:24 12:07:24 INFO - PROCESS | 29716 | Browser inner width/height: 1024/697 12:07:24 INFO - PROCESS | 29716 | __metrics 12:07:25 ERROR - PROCESS | 29716 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 12:07:25 INFO - TEST-INFO | 29716: exit 0 12:07:25 INFO - Browser initialized. 12:07:25 INFO - Running cycle 1/1 for kraken test... 12:07:25 INFO - TEST-INFO | started process 29836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbOcuR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:37 INFO - PROCESS | 29836 | RSS: Main: 167796736 12:07:37 INFO - PROCESS | 29836 | 12:07:40 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43217/tests/kraken/driver.html?testName=audio-beat-detection) 12:07:41 INFO - PROCESS | 29836 | RSS: Main: 172900352 12:07:41 INFO - PROCESS | 29836 | 12:07:43 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43217/tests/kraken/driver.html?testName=audio-dft) 12:07:44 INFO - PROCESS | 29836 | RSS: Main: 172449792 12:07:44 INFO - PROCESS | 29836 | 12:07:47 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43217/tests/kraken/driver.html?testName=audio-fft) 12:07:48 INFO - PROCESS | 29836 | RSS: Main: 167141376 12:07:48 INFO - PROCESS | 29836 | 12:07:50 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43217/tests/kraken/driver.html?testName=audio-oscillator) 12:07:50 INFO - PROCESS | 29836 | RSS: Main: 167792640 12:07:50 INFO - PROCESS | 29836 | 12:07:53 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:53 INFO - PROCESS | 29836 | RSS: Main: 167895040 12:07:53 INFO - PROCESS | 29836 | 12:07:56 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43217/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:57 INFO - PROCESS | 29836 | RSS: Main: 168468480 12:07:57 INFO - PROCESS | 29836 | 12:08:00 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43217/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:01 INFO - PROCESS | 29836 | RSS: Main: 165777408 12:08:01 INFO - PROCESS | 29836 | 12:08:04 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43217/tests/kraken/driver.html?testName=json-parse-financial) 12:08:05 INFO - PROCESS | 29836 | RSS: Main: 167419904 12:08:05 INFO - PROCESS | 29836 | 12:08:06 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:07 INFO - PROCESS | 29836 | RSS: Main: 167841792 12:08:07 INFO - PROCESS | 29836 | 12:08:08 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:09 INFO - PROCESS | 29836 | RSS: Main: 168226816 12:08:09 INFO - PROCESS | 29836 | 12:08:11 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:12 INFO - PROCESS | 29836 | RSS: Main: 168665088 12:08:12 INFO - PROCESS | 29836 | 12:08:14 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:15 INFO - PROCESS | 29836 | RSS: Main: 168390656 12:08:15 INFO - PROCESS | 29836 | 12:08:18 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:18 INFO - PROCESS | 29836 | RSS: Main: 168075264 12:08:18 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | Cycle 1(1): loaded http://localhost:43217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43217/tests/kraken/driver.html?testName=ai-astar) 12:08:20 INFO - PROCESS | 29836 | RSS: Main: 169345024 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | __start_tp_report 12:08:20 INFO - PROCESS | 29836 | _x_x_mozilla_page_load 12:08:20 INFO - PROCESS | 29836 | _x_x_mozilla_page_load_details 12:08:20 INFO - PROCESS | 29836 | |i|pagename|runs| 12:08:20 INFO - PROCESS | 29836 | |0;ai-astar;114;109;111;112;111;112;110;110;112;112 12:08:20 INFO - PROCESS | 29836 | |1;audio-beat-detection;150;135;160;178;130;161;147;135;188;127 12:08:20 INFO - PROCESS | 29836 | |2;audio-dft;162;162;164;163;165;164;178;168;165;163 12:08:20 INFO - PROCESS | 29836 | |3;audio-fft;75;77;75;163;77;76;77;75;178;75 12:08:20 INFO - PROCESS | 29836 | |4;audio-oscillator;84;85;155;85;86;85;154;84;85;141 12:08:20 INFO - PROCESS | 29836 | |5;imaging-gaussian-blur;118;117;118;119;118;118;117;117;118;119 12:08:20 INFO - PROCESS | 29836 | |6;imaging-darkroom;148;148;147;148;147;148;149;147;147;147 12:08:20 INFO - PROCESS | 29836 | |7;imaging-desaturate;98;96;97;96;95;96;96;97;96;96 12:08:20 INFO - PROCESS | 29836 | |8;json-parse-financial;53;54;54;53;53;53;55;53;54;54 12:08:20 INFO - PROCESS | 29836 | |9;json-stringify-tinderbox;62;61;62;63;62;62;61;61;62;62 12:08:20 INFO - PROCESS | 29836 | |10;stanford-crypto-aes;82;79;80;81;86;86;83;80;108;82 12:08:20 INFO - PROCESS | 29836 | |11;stanford-crypto-ccm;124;125;126;123;133;122;133;126;125;125 12:08:20 INFO - PROCESS | 29836 | |12;stanford-crypto-pbkdf2;162;161;165;159;158;157;160;164;161;160 12:08:20 INFO - PROCESS | 29836 | |13;stanford-crypto-sha256-iterative;65;68;63;66;61;61;62;65;62;63 12:08:20 INFO - PROCESS | 29836 | __end_tp_report 12:08:20 INFO - PROCESS | 29836 | __start_cc_report 12:08:20 INFO - PROCESS | 29836 | _x_x_mozilla_cycle_collect,895 12:08:20 INFO - PROCESS | 29836 | __end_cc_report 12:08:20 INFO - PROCESS | 29836 | __startTimestamp1465240100863__endTimestamp 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | ------- Summary: start ------- 12:08:20 INFO - PROCESS | 29836 | Number of tests: 14 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.12 12:08:20 INFO - PROCESS | 29836 | Values: 114.0 109.0 111.0 112.0 111.0 112.0 110.0 110.0 112.0 112.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.00 stddev:20.62 (13.3%) stddev-sans-first:21.86 12:08:20 INFO - PROCESS | 29836 | Values: 150.0 135.0 160.0 178.0 130.0 161.0 147.0 135.0 188.0 127.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.77 (2.9%) stddev-sans-first:4.89 12:08:20 INFO - PROCESS | 29836 | Values: 162.0 162.0 164.0 163.0 165.0 164.0 178.0 168.0 165.0 163.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:40.06 (53.1%) stddev-sans-first:41.85 12:08:20 INFO - PROCESS | 29836 | Values: 75.0 77.0 75.0 163.0 77.0 76.0 77.0 75.0 178.0 75.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:85.00 stddev:31.69 (37.3%) stddev-sans-first:32.74 12:08:20 INFO - PROCESS | 29836 | Values: 84.0 85.0 155.0 85.0 86.0 85.0 154.0 84.0 85.0 141.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 12:08:20 INFO - PROCESS | 29836 | Values: 118.0 117.0 118.0 119.0 118.0 118.0 117.0 117.0 118.0 119.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 12:08:20 INFO - PROCESS | 29836 | Values: 148.0 148.0 147.0 148.0 147.0 148.0 149.0 147.0 147.0 147.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.60 12:08:20 INFO - PROCESS | 29836 | Values: 98.0 96.0 97.0 96.0 95.0 96.0 96.0 97.0 96.0 96.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 12:08:20 INFO - PROCESS | 29836 | Values: 53.0 54.0 54.0 53.0 53.0 53.0 55.0 53.0 54.0 54.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 12:08:20 INFO - PROCESS | 29836 | Values: 62.0 61.0 62.0 63.0 62.0 62.0 61.0 61.0 62.0 62.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.00 stddev:8.53 (10.4%) stddev-sans-first:8.99 12:08:20 INFO - PROCESS | 29836 | Values: 82.0 79.0 80.0 81.0 86.0 86.0 83.0 80.0 108.0 82.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:125.50 stddev:3.79 (3.0%) stddev-sans-first:3.94 12:08:20 INFO - PROCESS | 29836 | Values: 124.0 125.0 126.0 123.0 133.0 122.0 133.0 126.0 125.0 125.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.50 (1.6%) stddev-sans-first:2.60 12:08:20 INFO - PROCESS | 29836 | Values: 162.0 161.0 165.0 159.0 158.0 157.0 160.0 164.0 161.0 160.0 12:08:20 INFO - PROCESS | 29836 | 12:08:20 INFO - PROCESS | 29836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:2.32 (3.6%) stddev-sans-first:2.40 12:08:20 INFO - PROCESS | 29836 | Values: 65.0 68.0 63.0 66.0 61.0 61.0 62.0 65.0 62.0 63.0 12:08:20 INFO - PROCESS | 29836 | -------- Summary: end -------- 12:08:20 INFO - PROCESS | 29836 | 12:08:21 INFO - TEST-INFO | 29836: exit 0 12:08:21 INFO - TEST-OK | kraken | took 60958ms 12:08:21 INFO - SUITE-END | took 1170s 12:08:22 INFO - Completed test suite (00:19:31) 12:08:22 INFO - javascript benchmark 12:08:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7206.915757546518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.6588175300717, 3168.160437484066, 3171.6035495563056, 3180.7137357637807, 3183.952240716388, 5484.780608775649, 5493.91759123613, 5511.834644960652, 5622.156676498527, 5638.633488823224, 5395.433479484646, 5537.252470916425, 5554.888902221964, 5573.972130139354, 5606.859828504289, 4960.826371077013, 5067.797288108472, 5083.949160508385, 5107.897842043157, 5130.769115389817, 4990.725510096943, 5170.3020092287625, 5177.48225177483, 5202.531772140506, 5206.140986737184, 4999.700017998932, 5021.447640759514, 5041.991601679661, 5055.646104772667, 5083.288339632436, 5060.974695126538, 5079.288899554065, 5089.287499750038, 5107.897842043176, 5109.029284435946, 5060.696358218482, 5071.264666623356, 5081.720505372203, 5086.720230387327, 5112.642115051948, 5401.297831281948, 5422.132458806572, 5459.454054594548, 5504.80733174341, 5550.139728342114, 5902.203202567642, 5937.732802023919, 5938.910916336258, 5950.315713692938, 5972.70136493178, 5714.714264286769, 5982.132590774357, 5994.550408719363, 6007.3992600739575, 6011.458968692838, 5493.917591236134, 5502.174673798922, 5503.284573005523, 5525.281713377275, 5543.750531226065, 6040.909386359208, 6049.606775559574, 6057.546188914629, 6061.969690151521, 6086.695665216722, 5680.204771332017, 5720.141978703228, 5751.194832723422, 5824.213731146326, 5851.736671849777, 5868.941310586925, 5872.060470324727, 5896.439838215363, 5938.703064846741, 5950.2264705587995, 5746.281714785652, 5867.6772777497645, 5876.794312199053, 5898.498627616615, 5915.40845915405, 5869.148973398833, 5882.617629854046, 5942.1978032965, 5942.1978032965, 5942.8811423771285, 4370.978145109254, 4435.800388982503, 4474.463064432289, 4511.503734589192, 4513.887152821206, 3996.440498330236, 3997.380406037069, 4004.6596039336982, 4037.0714735610973, 4044.0, 5472.398036216013, 5736.110902810071, 5747.942520574741, 5754.367019627837, 5771.105478650816, 5798.304203495608, 5817.563682723812, 5853.824385268449, 5880.176775251468, 5905.527557795366, 5576.414476479911, 5597.076482380443, 5607.467290607386, 5613.46672066153, 5631.71841407928, 4959.553640172402, 5032.597392208614, 5038.647294689336, 5076.213186956028, 5077.771500282496, 6094.451499365078, 6204.162438070893, 6209.348018457997, 6212.0, 6215.782447614311, 6005.849853753691, 6017.2779266488305, 6018.337982821974, 6036.732286219943, 6062.666553339609, 5874.530037597067, 6023.5181185505935, 6111.266648002268, 6155.415235552616, 6175.289841668086, 5885.0, 5885.646861188342, 5888.970555147368, 5901.468867801918, 5934.614250073904, 5927.85180370477, 5983.252093488314, 5995.250593675791, 6000.5799594028, 6002.399760024137, 5649.802256920988, 5742.827715168552, 5776.826695199151, 5793.884122317614, 5851.970740146272, 5530.142827861688, 5679.858003549944, 5707.971460142673, 5767.480926716616, 5776.508996735324, 5678.4605462480995, 5693.089105743061, 5717.828465146053, 5718.1708652246025, 5732.856678582902, 5609.102543593006, 5799.942000580109, 5808.012637851491, 5840.0, 5855.238818953509, 5718.170865224436, 5739.282589676291, 5776.364599894092, 5777.162311464898, 5816.156657284585], "value": 5459.198032724661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9164921086442, 600.4175949329152, 621.0714981103251, 643.1767337807605, 652.6116960408556, 38346.616533834655, 42973.140537189276, 43113.35329970049, 43357.7832110839, 43540.564594354044, 44249.0, 44452.777736111275, 44541.331880021746, 44542.55457445425, 44949.0, 8670.956645216766, 8843.690470833522, 8864.468131912074, 8864.556772161366, 8867.467951922874, 8557.48655080697, 8580.056193818675, 8582.313414926792, 8607.6126574304, 8621.13788621139, 8533.232009119178, 8600.35497337699, 8603.268722158624, 8621.180987806149, 8663.870041949376, 8635.481871087723, 8648.697295594624, 8650.178233067849, 8654.177853103914, 8659.783505412384, 8690.826183476294, 8754.86867696985, 8789.912100879037, 8790.252828509585, 8800.779980500538, 31989.360212795615, 40089.0, 40845.59154408448, 40925.795371023254, 41097.58902410968, 3382.678645528671, 3411.4371128763723, 3548.0420286522494, 3672.779633222015, 4157.355609880443, 30408.54387184194, 30445.391092178033, 31057.844710776528, 31087.0, 31297.374052518822, 4149.107941792529, 4161.25097482453, 4250.574942505756, 4279.572042795727, 4410.691251612388, 302067.9999999978, 303552.0, 304130.0, 304731.0, 305511.0, 35014.64985350165, 35052.12369690778, 35133.297334053175, 35137.824310878284, 35228.47157292643, 35623.64376356255, 35799.64200358015, 35960.64039359625, 35998.64001359953, 36029.459558106646, 15483.374245704264, 15533.223338833013, 15546.9222653886, 15618.609534761494, 15634.140122293156, 13142.868571314164, 13149.145305555108, 13242.668933276746, 13312.800307995389, 13355.465781368637, 7916.643751031217, 8121.4721043132, 8127.3904457165945, 8193.0, 8208.917910820936, 3188.4739018062223, 3228.5157226416227, 3233.9949231476166, 3241.821699806533, 3300.4389253826425, 1094.2395035450445, 1097.1277834121893, 1191.0888170549536, 1193.8507686539183, 1216.403962058585, 33183.502247466306, 33496.66503334935, 33541.161470962936, 33576.328473430396, 34305.82847085749, 1136.8976792088586, 1139.9088072954144, 1192.9582464613698, 1251.5556977272936, 1304.1197191895621, 16510.83489165117, 16784.0, 16795.004787743415, 16805.663886722195, 16887.493375198763, 578384.0, 587779.0, 588308.0, 588369.0, 593558.0, 57018.42981570131, 57070.0, 57460.712696437084, 57616.13575796366, 57624.42375576274, 1375.3810785146525, 1396.5670642100981, 1406.8593140686055, 1410.5204230561658, 1433.2618701368804, 30068.24829379283, 31142.0, 31224.21939451532, 31648.525272120474, 32196.35607287888, 48439.51560484491, 48735.512644874514, 48896.26655600098, 49483.50516494789, 49527.25709114294, 511271.0, 512565.0, 513723.0, 515941.2608810946, 517793.0, 25931.0, 26017.47965040651, 26180.607290891032, 26209.213723588324, 27707.168784936483, 47591.524084760094, 47851.5214847861, 48070.519294808, 48355.758221210075, 48769.51230487791, 40386.39420408755, 40741.59258407378, 40997.38503922384, 41181.794091029355, 41344.586554134075, 40373.394399084624, 40560.39159412552, 41013.79493102516, 41022.38466422947, 41490.170196596504, 35265.82367088148, 40461.0, 40519.1896162081, 40931.0, 41824.0, 34675.0, 36076.27847443089, 36464.27071458609, 36665.81667091647, 36701.26597468089, 27825.16524504268, 27976.300592484535, 28170.43659126847, 28470.145895623165, 28552.857235713687], "value": 18657.75551494821, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.37290843017445, 385.6606186555831, 388.90860647747775, 396.90474286171326, 412.8843923701365, 14203.360848761804, 18103.0, 19081.236750529963, 19539.706904396444, 19664.115114819833, 18426.44720658379, 18683.71974420385, 19008.334708285212, 19159.137838797255, 19193.0, 5672.659640421567, 5709.086546152616, 5855.385184555625, 5858.824235272928, 5927.792527261547, 5229.137192363255, 5516.613837031409, 5690.260266165393, 5749.59752817303, 5797.826065218029, 5499.3675727291475, 5521.061419558665, 5532.170174473841, 5574.637648552852, 5591.860203494904, 5645.633033852807, 6189.9381006189815, 6201.844953876144, 6214.5960512566535, 6217.751289948396, 5402.837914862561, 5412.512873841334, 5655.208270842086, 5683.460071293221, 5692.9146062809095, 13621.795673064911, 13803.930980345134, 13842.446302147902, 20510.38468845937, 22556.0, 2185.7704940981284, 2195.829510798142, 2204.4268490192503, 2245.887705614729, 2531.153811672595, 10304.0, 10437.478126093665, 10520.158387329071, 10666.679999599946, 10741.677749667522, 1919.280269898788, 1972.5167334003118, 2011.4870707969374, 2047.4369548374168, 2065.2565076572423, 66484.0, 66624.0, 74523.0, 75691.62154189193, 85669.57165214197, 10777.62278320255, 10966.187175473964, 10988.285761425483, 11022.50398732059, 11023.0, 15287.464938727091, 15308.234588270541, 15421.614459638598, 15477.9226103871, 15527.689446211012, 7645.235476452422, 7943.602819859099, 8243.299319557906, 8290.751277461686, 8604.397692161489, 7425.405967522585, 7631.885521717179, 7654.578998155043, 7786.065672119382, 7958.562279074591, 4652.97673511637, 4714.269288260325, 4789.413716593071, 4838.129136755418, 4850.272459131159, 1957.3736404350757, 1961.8724782889067, 1962.1268535501565, 1964.361582485698, 1993.312307253995, 874.4665753890122, 927.590063104078, 1032.390889375272, 1077.1921059205595, 1094.7044298039484, 19016.334428294944, 19074.713879291823, 19215.423537293904, 19549.8186686383, 19611.901940490206, 976.4678250353575, 998.9550470228858, 1015.7663737340453, 1017.3133135133903, 1020.2195320579763, 10280.331778434378, 10717.785644287227, 10731.678049658523, 10735.141188704885, 10757.623483178208, 168780.0, 169645.0, 169861.0, 170556.0, 170644.0, 91404.0, 97033.5148324268, 98403.0, 98575.50712246537, 98814.50592747134, 989.2135752077116, 1010.6109147977934, 1016.0499932563077, 1030.294248439821, 1030.6753372687579, 16842.831571684615, 17141.400050998156, 17236.138193090046, 17245.310187592357, 17643.382481613597, 41224.175516488904, 41568.376474352306, 41718.0, 42318.36522452104, 43045.56954430541, 54848.45151548433, 57677.71161144167, 66205.0, 66263.0, 66524.33475665376, 5964.731587078505, 8009.359251260002, 8321.167883211872, 8462.11147829469, 8647.221750042274, 12061.819072714092, 12644.620661380173, 12711.237325760483, 12848.229106253655, 13314.600561983156, 11085.667429977113, 11239.157063220455, 11294.887051129384, 11516.827247591125, 11584.652460426201, 9065.954670226607, 11058.11535077208, 11098.667039988813, 11236.325820450798, 11453.427328633701, 11221.66335009951, 11402.486888090221, 11514.654560363202, 11657.766844663229, 12143.0, 8358.749237522885, 8485.193906578865, 8504.91495085066, 8605.139486051345, 8693.26107280863, 10468.895311047097, 11057.11543076568, 11133.443327833738, 11195.776084478102, 11572.884271157518], "value": 8805.17818319064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.6733734909653, 1506.2167672810135, 1532.4559781277644, 1675.7570152327912, 1853.5829438376368, 7758.185390533998, 8544.786380340487, 8597.226249637532, 9055.0, 9078.137576930198, 8741.95629021854, 8755.562221888911, 8806.339524535653, 8832.955835220815, 8849.336299777526, 2304.608216603173, 2328.359701082199, 2330.254318618043, 2335.614623587106, 2347.753485883983, 2264.2188444986455, 2277.1346888182466, 2329.9534009319887, 2335.2060299498166, 2335.369450248432, 2262.5474905018978, 2288.1762565476415, 2304.1129165271323, 2340.6137987232087, 2343.5078633486987, 2235.519363336882, 2239.5520895820737, 2240.932772016842, 2241.1035585765662, 2251.279590531031, 2099.88450635215, 2104.6106470303043, 2106.8735875847497, 2116.9259075932423, 2119.8198153157, 8823.250023747989, 8921.687740929035, 8936.508492032935, 8949.731508054703, 8951.373403861733, 4990.975045124787, 5017.67385119966, 5036.445990940993, 5074.035933172685, 5083.212102124176, 3279.7212236959886, 3385.5091011803397, 3555.0756803231347, 3562.7684200526883, 3569.1969306906, 1258.6916205529703, 1263.5261776833688, 1266.7593157300084, 1281.7564662714055, 2166.350094971518, 12377.0, 12615.243085414904, 12708.301043442607, 12771.808422873664, 12784.936075319656, 4456.6211871991245, 4521.638268938543, 4536.387587675622, 4557.794899229476, 4596.609288210473, 9890.950545247371, 9909.504524773733, 9959.751006224757, 9966.053224943618, 9978.201743860618, 5223.582113430916, 5224.92162617561, 5229.032628963654, 5234.685918844882, 5246.606504512177, 4223.1975924574235, 4712.9057418851435, 4856.732879691651, 4862.17343051682, 4900.583450406755, 3748.11919198988, 3752.9061773455883, 3776.735628506033, 3847.2305538892333, 3902.2585708715255, 1109.2401704832216, 1123.9044681202026, 1124.8706398764084, 1140.5095808802296, 1141.5262665993687, 858.8582883824099, 1002.7242508310127, 1003.307717674802, 1006.4716024087413, 1025.9794804103876, 6157.6613286269685, 6186.81439556814, 6235.968820155961, 6253.437190652863, 6295.0, 454.7680682851769, 460.4635599526514, 463.2425983516907, 466.6709969471514, 469.71816909853817, 4160.854370097032, 4261.488621365394, 4302.892427689333, 4376.584224498668, 4379.58393952574, 10822.242443028912, 11219.270747401557, 11281.32312061279, 11347.0, 11362.659120226406, 11088.390138542296, 11157.107431405468, 11197.72005699864, 11211.831822522669, 11230.775384492428, 8068.0, 8379.58102094905, 8386.203310685476, 8388.706395276258, 8577.614007369559, 6161.44546990773, 6209.59637623553, 6292.276388215414, 6396.26442959047, 6415.230172379344, 10308.742281443025, 10495.265331426726, 10591.099756520782, 10694.518746656575, 10697.786044279226, 10737.516811743333, 10776.892231077589, 10867.51096200657, 10889.891101088888, 10891.509882055168, 7830.412719046209, 7956.92043079585, 7974.202579741979, 8009.919900800917, 8179.509229446252, 8579.528125953133, 8603.784905377415, 8620.61207245663, 8648.394612377073, 8678.783030424038, 7497.175310715926, 7639.236076392316, 7754.030746156731, 7807.843843122992, 7832.37341012729, 7558.093028836355, 7676.501027433199, 7678.308952194329, 7770.728024519115, 7785.104712957856, 6968.65156742171, 6979.8604027918145, 7019.789406317818, 7023.683934223074, 7029.051078104595, 4877.682950608341, 4883.804647814048, 4974.204127339608, 5052.343195384577, 5057.418396884405, 4935.531124543163, 4966.205407134841, 4971.925421118758, 4994.9500504994485, 5090.338256026693], "value": 4582.8938807694285, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.8627176585834, 332.775376620781, 341.5935037305606, 343.52936477026475, 346.4318517631084, 5639.830805075844, 5669.631473954195, 5680.579855036241, 5702.686352250625, 5736.741846616902, 5568.5266752326, 5596.776128954847, 5626.943730562693, 5627.774889004435, 5660.773569057233, 4158.8978920586, 4199.2441360555085, 4344.9348259776125, 4350.847720329789, 4360.23695853226, 4334.869953901388, 4341.934870976938, 4344.783460631028, 4376.671749618776, 4385.298352263639, 4335.414719012941, 4336.718113322624, 4343.739375637456, 4345.652347812167, 4349.347597860315, 4274.123804620045, 4309.504406993205, 4309.762963037032, 4319.0713996490595, 4334.588214119638, 3800.8669696560764, 3804.8287827047848, 3818.5417749869916, 3836.5204349456317, 3842.9807850960847, 5394.7842086316505, 5410.215518749798, 5410.592286432539, 5428.88707814897, 5461.972690136564, 4892.363992680965, 4930.383702037246, 5034.874128146789, 5041.873953151164, 5070.543651071384, 5733.827985160452, 5778.768849246025, 5781.913271300934, 5848.385919478436, 5864.70676466175, 4271.97864010681, 4275.935860962088, 4281.100968796556, 4283.850065247732, 4287.335463003239, 5769.221155144044, 6053.424924632153, 6053.878922421527, 6070.817875463699, 6156.96921515394, 4269.316909294498, 4270.846871344719, 4283.914321713548, 4296.2911119664905, 4307.956920430755, 4343.82624695015, 4351.303791393362, 4361.934570981438, 4363.6072753452345, 4374.58441448062, 4831.178699621073, 4956.132676781549, 4968.0, 4972.154733695281, 5010.173321401928, 5774.769009239667, 5789.8552536186935, 5862.710203755167, 5912.497437717756, 5925.40745925404, 1488.761798112297, 1501.6996600679909, 1509.8565636264536, 1510.1316742872891, 1511.8790496760232, 958.9328746987644, 965.5461932891529, 1018.5162048027128, 1020.505055048301, 1030.1141018723893, 5648.6443253619655, 5701.258836351248, 5716.485516303553, 5735.741891614887, 5783.537317014629, 6033.607815492067, 6089.512838972872, 6098.231512861309, 6105.725242364104, 6106.084087386838, 5501.284832971688, 5652.0, 5668.914966275509, 5747.942520574741, 5750.0, 3192.4892017277125, 3204.6955539223736, 3227.0964130043626, 3227.177069847174, 3245.594300712411, 5957.910631340534, 6145.661988590581, 6191.133241346215, 6192.318844927055, 6207.255129384503, 6038.18484504595, 6053.122297266872, 6087.6956152192215, 6109.236345456818, 6122.418370254819, 5759.481646651905, 6188.391018335175, 6210.795167715396, 6241.78153764616, 6248.4064013918605, 5923.674197919156, 5924.052151655715, 5996.5502587305255, 6015.578909476295, 6030.969845150922, 5930.703464826827, 5973.761049557969, 5976.61152025117, 5978.701064946822, 5984.700764961822, 5952.769615844984, 6170.290416602148, 6208.596441231305, 6229.719662615103, 6237.313895471585, 4258.339957306623, 4264.5309016007595, 4275.315949448198, 4277.443932288783, 4296.548862369406, 5819.825405237681, 5879.147523609138, 6020.668863212565, 6071.726772295346, 6082.665453399928, 5787.334456537384, 5906.527477801679, 5908.96593096215, 5939.138824870283, 5965.492933100735, 5701.945140149086, 5916.822495325147, 5922.2597175353085, 5935.7032148391545, 5958.19564358806, 5733.3406658234835, 5764.308283006066, 5775.711214439178, 5808.94191058084, 5831.504322132497, 5944.910826337695, 5948.0, 5952.464278214981, 5958.19564358806, 5979.521638269015, 5613.4282400927805, 5735.627184233012, 5808.5353171747, 5821.79623713168, 5828.271466066742], "value": 4474.534759781845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.9633018349084, 774.868272393693, 827.5034979012593, 844.8437039147755, 862.4264863865529, 14540.345684444199, 15382.769258461118, 15560.53318400447, 15601.375944962188, 15651.060936343813, 14731.558053258419, 14865.182414967172, 14905.32926018329, 14917.403303867832, 14977.101373917545, 663.1776597019697, 782.4679218131669, 803.2128514056228, 810.432697112021, 819.3690858039306, 796.3231253434564, 805.3396215103618, 810.8905297784812, 811.5658122904248, 814.9307308878753, 852.5438890193748, 855.9229669329759, 856.5888373580685, 858.0347109501811, 864.8962124545063, 853.8463076646201, 858.103282070235, 858.5750053723447, 858.8196478739472, 859.8667206582959, 618.0358640520757, 620.7020630097534, 627.316225314405, 627.6359711367396, 627.9811605651838, 15156.848431515655, 15243.237838108162, 15250.161241131733, 15264.38942442301, 15313.693726125526, 15285.770713439308, 15403.3838646454, 15560.688786224213, 15575.143367114804, 15576.299066542033, 12584.68538286541, 12622.936885315607, 12729.554465593752, 12801.359932003363, 12916.41876115577, 3934.3705007198996, 3957.1096503286817, 3973.264945985002, 4004.659603933669, 4115.42384066231, 74113.0, 74200.62899685522, 74286.25713742847, 75688.0, 78248.21751782524, 11814.88185118155, 11972.461239244254, 12084.939575302067, 12122.75754484923, 12334.568290109803, 20691.275805347042, 20784.896075519526, 20808.58382832335, 20836.27073052436, 20843.895780521, 8200.794980125545, 8268.875966860502, 8351.415400921876, 8540.572971351532, 8755.605997730117, 4732.621390288768, 4764.2615394613895, 4852.2479015752615, 4854.75726213695, 4903.338049363361, 3590.2998915211806, 3715.8327875245136, 3725.3666876631037, 3726.5155529780955, 3735.1035751419463, 640.4492136762381, 646.7542333913083, 650.5803756576981, 654.4764188649061, 672.7847088931495, 716.9962053125562, 733.3802936518633, 751.1244600365167, 760.5777196642314, 784.1491981200461, 10098.343607665625, 10492.527836247387, 10518.211134164969, 10530.684079477627, 10601.204909631808, 610.4201009041428, 669.4276393683331, 745.4632664481564, 785.7053604898164, 787.1656044592636, 4545.795439205243, 4594.310853372021, 4627.0, 4747.406574178228, 4754.5007774183905, 112641.0, 113609.0, 114974.42512787382, 116608.41695791636, 119544.0, 91857.0, 93545.5322723382, 95979.52010240043, 98400.0, 98846.5057674707, 88509.0, 89756.5512172435, 90266.09733902708, 91050.54474727584, 91602.0, 9459.621615135318, 9464.574094165917, 9644.373115747454, 9700.175485083564, 9775.902240977499, 46840.0, 52028.739856300475, 52220.73889630527, 52932.73533632307, 52956.47043529515, 68119.65940170268, 68415.65792171007, 78568.60715696384, 80055.59972200335, 80869.59565202137, 12770.61688149357, 12849.0, 12907.354632268161, 13088.541901033419, 13094.345282735634, 13534.255615941218, 13614.795778063535, 13772.24252666073, 13956.232407217294, 14377.209253491159, 12857.164284321489, 13329.200247985153, 13361.732765344834, 13383.063185577306, 13717.0, 12900.225986440844, 13139.934300328438, 13203.867961320264, 13263.602091937257, 13299.734005320033, 12541.74916501683, 12565.0, 12580.288814799473, 12617.315931055316, 12793.616191513896, 10400.167986560906, 10805.405702686428, 11034.889651103385, 11116.333020018501, 11306.94346528262, 10960.835587466354, 10995.945020274847, 11129.833052504056, 11135.164862635173, 11169.609063682732], "value": 7618.038825120812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 111.0, 112.0, 111.0, 112.0, 110.0, 110.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 160.0, 178.0, 130.0, 161.0, 147.0, 135.0, 188.0, 127.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 165.0, 164.0, 178.0, 168.0, 165.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 163.0, 77.0, 76.0, 77.0, 75.0, 178.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 155.0, 85.0, 86.0, 85.0, 154.0, 84.0, 85.0, 141.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 55.0, 53.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 80.0, 81.0, 86.0, 86.0, 83.0, 80.0, 108.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 126.0, 123.0, 133.0, 122.0, 133.0, 126.0, 125.0, 125.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 165.0, 159.0, 158.0, 157.0, 160.0, 164.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 63.0, 66.0, 61.0, 61.0, 62.0, 65.0, 62.0, 63.0], "value": 63.6, "unit": "score"}]}]} 12:08:22 INFO - Return code: 0 12:08:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:22 ERROR - # TBPL SUCCESS # 12:08:22 INFO - Running post-action listener: _resource_record_post_action 12:08:22 INFO - ##### 12:08:22 INFO - ##### Finished run-tests step (success) 12:08:22 INFO - ##### 12:08:22 INFO - Running post-run listener: _resource_record_post_run 12:08:22 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544747520; Read time: 8; Write time: 412840 12:08:22 INFO - TinderboxPrint: CPU usage
13.4% 12:08:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 12:08:22 INFO - TinderboxPrint: I/O write bytes / time
544,747,520 / 412,840 12:08:22 INFO - TinderboxPrint: CPU idle
8,210.1 (86.5%) 12:08:22 INFO - TinderboxPrint: CPU user
1,225.1 (12.9%) 12:08:22 INFO - TinderboxPrint: Swap in / out
0 / 0 12:08:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247959552; Read time: 0; Write time: 209940 12:08:22 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296202240; Read time: 8; Write time: 202880 12:08:22 INFO - Running post-run listener: _upload_blobber_files 12:08:22 INFO - Blob upload gear active. 12:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:22 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 12:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:23 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:08:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:24 INFO - (blobuploader) - INFO - Done attempting. 12:08:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:28 INFO - (blobuploader) - INFO - Done attempting. 12:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:08:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:29 INFO - (blobuploader) - INFO - Done attempting. 12:08:29 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:29 INFO - Return code: 0 12:08:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb69be6a61de5dbd7f2d12aa1bf71a540bd949d090e673375332c448f2d05e7ed3cb0e11203cc43939f0e07fdf8cd9b589a8a092fc9f6acb5e95320c0a87458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f33dcfbb8d652c2701cbee45b884ca4bab27079c351e884e0523bae67bec8d074b13802d0c67ed186498088ea45d19ff569f33f76490899b4ae02b189d74bdcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05124fdec13d3ef391ab22b36bf2d47f399999521ff2f0e7a4d9d15f25ebf0fd22d553337565fc5da7b9b0aaa0e0ac444cfdb99dc9f6bbaa32fda3e4f3afdf37"} 12:08:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:29 INFO - Contents: 12:08:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb69be6a61de5dbd7f2d12aa1bf71a540bd949d090e673375332c448f2d05e7ed3cb0e11203cc43939f0e07fdf8cd9b589a8a092fc9f6acb5e95320c0a87458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f33dcfbb8d652c2701cbee45b884ca4bab27079c351e884e0523bae67bec8d074b13802d0c67ed186498088ea45d19ff569f33f76490899b4ae02b189d74bdcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05124fdec13d3ef391ab22b36bf2d47f399999521ff2f0e7a4d9d15f25ebf0fd22d553337565fc5da7b9b0aaa0e0ac444cfdb99dc9f6bbaa32fda3e4f3afdf37"} 12:08:29 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:29 INFO - Copying logs to upload dir... 12:08:29 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1436.523823 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 56 secs) (at 2016-06-06 12:08:29.265501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:08:29.269109) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 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/sha512/5fb69be6a61de5dbd7f2d12aa1bf71a540bd949d090e673375332c448f2d05e7ed3cb0e11203cc43939f0e07fdf8cd9b589a8a092fc9f6acb5e95320c0a87458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f33dcfbb8d652c2701cbee45b884ca4bab27079c351e884e0523bae67bec8d074b13802d0c67ed186498088ea45d19ff569f33f76490899b4ae02b189d74bdcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05124fdec13d3ef391ab22b36bf2d47f399999521ff2f0e7a4d9d15f25ebf0fd22d553337565fc5da7b9b0aaa0e0ac444cfdb99dc9f6bbaa32fda3e4f3afdf37"} build_url:https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/WOpfxRFbQs6rR6AH-5muSA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fb69be6a61de5dbd7f2d12aa1bf71a540bd949d090e673375332c448f2d05e7ed3cb0e11203cc43939f0e07fdf8cd9b589a8a092fc9f6acb5e95320c0a87458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f33dcfbb8d652c2701cbee45b884ca4bab27079c351e884e0523bae67bec8d074b13802d0c67ed186498088ea45d19ff569f33f76490899b4ae02b189d74bdcc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05124fdec13d3ef391ab22b36bf2d47f399999521ff2f0e7a4d9d15f25ebf0fd22d553337565fc5da7b9b0aaa0e0ac444cfdb99dc9f6bbaa32fda3e4f3afdf37"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:08:29.298077) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:08:29.298892) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1465238671.463407-989064689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:08:29.381732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:08:29.382589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:08:29.383331) ========= ========= Total master_lag: 0.19 =========