builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1465237981.97 results: success (0) buildid: 20160606083115 builduid: b8910be4b18a4cf09cdff0b9cc7cee10 revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:01.971619) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:01.972080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:01.972365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:01.987177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:01.987469) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 11:33:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 202M=0s 2016-06-06 11:33:02 (202 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:02.149895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:02.150210) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:02.200262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:33:02.200670) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 11:33:02,539 truncating revision to first 12 chars 2016-06-06 11:33:02,539 Setting DEBUG logging. 2016-06-06 11:33:02,539 attempt 1/10 2016-06-06 11:33:02,539 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:33:03,433 unpacking tar archive at: fx-team-8ee8066ffeea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 11:33:03.481831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:03.482153) ========= script_repo_revision: 8ee8066ffeea90aabada756a2126349680bccb37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:03.482575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:03.482895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 11:33:03.493017) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 18 secs) (at 2016-06-06 11:33:03.493289) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:33:03 INFO - MultiFileLogger online at 20160606 11:33:03 in /builds/slave/test 11:33:03 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:33:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:33:03 INFO - {'append_to_log': False, 11:33:03 INFO - 'base_work_dir': '/builds/slave/test', 11:33:03 INFO - 'blob_upload_branch': 'Fx-Team', 11:33:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:33:03 INFO - 'branch': 'Fx-Team', 11:33:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:33:03 INFO - 'config_files': ('talos/linux_config.py',), 11:33:03 INFO - 'default_actions': ('clobber', 11:33:03 INFO - 'read-buildbot-config', 11:33:03 INFO - 'download-and-extract', 11:33:03 INFO - 'populate-webroot', 11:33:03 INFO - 'create-virtualenv', 11:33:03 INFO - 'install', 11:33:03 INFO - 'run-tests'), 11:33:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:33:03 INFO - 'download_minidump_stackwalk': True, 11:33:03 INFO - 'download_symbols': 'ondemand', 11:33:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:33:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:33:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:33:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:33:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:33:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:33:03 INFO - 'installer_path': 'installer.exe', 11:33:03 INFO - 'log_level': 'info', 11:33:03 INFO - 'log_name': 'talos', 11:33:03 INFO - 'log_to_console': True, 11:33:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:33:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:33:03 INFO - 'opt_config_files': (), 11:33:03 INFO - 'pip_index': False, 11:33:03 INFO - 'sps_profile': False, 11:33:03 INFO - 'sps_profile_interval': 0, 11:33:03 INFO - 'suite': 'dromaeojs-e10s', 11:33:03 INFO - 'system_bits': '32', 11:33:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:33:03 INFO - 'title': 'talos-linux64-ix-022', 11:33:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:33:03 INFO - 'use_talos_json': True, 11:33:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:33:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:33:03 INFO - 'work_dir': 'build'} 11:33:03 INFO - ##### 11:33:03 INFO - ##### Running clobber step. 11:33:03 INFO - ##### 11:33:03 INFO - Running pre-action listener: _resource_record_pre_action 11:33:03 INFO - Running main action method: clobber 11:33:03 INFO - rmtree: /builds/slave/test/build 11:33:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:33:04 INFO - Running post-action listener: _resource_record_post_action 11:33:04 INFO - ##### 11:33:04 INFO - ##### Finished clobber step (success) 11:33:04 INFO - ##### 11:33:04 INFO - ##### 11:33:04 INFO - ##### Running read-buildbot-config step. 11:33:04 INFO - ##### 11:33:04 INFO - Running pre-action listener: _resource_record_pre_action 11:33:04 INFO - Running main action method: read_buildbot_config 11:33:04 INFO - Using buildbot properties: 11:33:04 INFO - { 11:33:04 INFO - "project": "", 11:33:04 INFO - "product": "firefox", 11:33:04 INFO - "script_repo_revision": "production", 11:33:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:33:04 INFO - "repository": "", 11:33:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:33:04 INFO - "buildid": "20160606083115", 11:33:04 INFO - "pgo_build": "True", 11:33:04 INFO - "basedir": "/builds/slave/test", 11:33:04 INFO - "buildnumber": 426, 11:33:04 INFO - "slavename": "talos-linux64-ix-022", 11:33:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:33:04 INFO - "platform": "ubuntu64_hw", 11:33:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:33:04 INFO - "branch": "fx-team", 11:33:04 INFO - "repo_path": "integration/fx-team", 11:33:04 INFO - "revision": "8ee8066ffeea90aabada756a2126349680bccb37", 11:33:04 INFO - "stage_platform": "linux64-pgo", 11:33:04 INFO - "builduid": "b8910be4b18a4cf09cdff0b9cc7cee10", 11:33:04 INFO - "slavebuilddir": "test" 11:33:04 INFO - } 11:33:04 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:33:04 INFO - Running post-action listener: _resource_record_post_action 11:33:04 INFO - ##### 11:33:04 INFO - ##### Finished read-buildbot-config step (success) 11:33:04 INFO - ##### 11:33:04 INFO - ##### 11:33:04 INFO - ##### Running download-and-extract step. 11:33:04 INFO - ##### 11:33:04 INFO - Running pre-action listener: _resource_record_pre_action 11:33:04 INFO - Running main action method: download_and_extract 11:33:04 INFO - mkdir: /builds/slave/test/build/tests 11:33: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:33:04 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:33: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.test_packages.json 11:33: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.test_packages.json 11:33: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.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:33:04 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:33:06 INFO - Downloaded 1361 bytes. 11:33:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:33:06 INFO - Using the following test package requirements: 11:33:06 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:33:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:33:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'jsshell-linux-x86_64.zip'], 11:33:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:33:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:33:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:33:06 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:33:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:33:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:33:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:33:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:06 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:33:06 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:33:06 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:33:06 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:33:06 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:33:09 INFO - Downloaded 24443794 bytes. 11:33:09 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:33:09 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:33:10 INFO - Return code: 0 11:33:10 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:33: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:33:10 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:33:10 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:33:10 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:33:10 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:33:10 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:37:59 INFO - Downloaded 24443794 bytes. 11:37:59 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:37:59 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:38:01 INFO - Return code: 0 11:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:01 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:38:01 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:38:01 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:38:01 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:38:01 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:38:02 INFO - Downloaded 10833369 bytes. 11:38:02 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:38:02 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:38:02 INFO - Return code: 0 11:38:02 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:38:02 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:38:02 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:38:02 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:38:02 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:38:02 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:39:57 INFO - Downloaded 59181725 bytes. 11:39:57 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:39:57 INFO - mkdir: /builds/slave/test/properties 11:39:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:57 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:57 INFO - Contents: 11:39:57 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:39:58 INFO - Running post-action listener: _resource_record_post_action 11:39:58 INFO - Running post-action listener: set_extra_try_arguments 11:39:58 INFO - ##### 11:39:58 INFO - ##### Finished download-and-extract step (success) 11:39:58 INFO - ##### 11:39:58 INFO - ##### 11:39:58 INFO - ##### Running populate-webroot step. 11:39:58 INFO - ##### 11:39:58 INFO - Running pre-action listener: _resource_record_pre_action 11:39:58 INFO - Running main action method: populate_webroot 11:39:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:58 INFO - '--tppagecycles', 11:39:58 INFO - '7'], 11:39:58 INFO - 'tests': ['tsvgm']}}, 11:39:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['damp', 'tps']}, 11:39:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'tests': ['damp', 'tps']}, 11:39:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['dromaeo_dom']}, 11:39:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['a11yr', 11:39:58 INFO - 'ts_paint', 11:39:58 INFO - 'tpaint', 11:39:58 INFO - 'sessionrestore', 11:39:58 INFO - 'sessionrestore_no_auto_restore', 11:39:58 INFO - 'tabpaint']}, 11:39:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['tsvgx', 11:39:58 INFO - 'tsvgr_opacity', 11:39:58 INFO - 'tart', 11:39:58 INFO - 'tscrollx', 11:39:58 INFO - 'cart']}, 11:39:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:58 INFO - 'tsvgr_opacity', 11:39:58 INFO - 'tart', 11:39:58 INFO - 'tscrollx', 11:39:58 INFO - 'cart']}, 11:39:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'talos_options': ['--disable-e10s'], 11:39:58 INFO - 'tests': ['tp5o']}, 11:39:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'tests': ['tp5o']}, 11:39:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'talos_options': ['--disable-e10s', 11:39:58 INFO - '--xperf_path', 11:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:58 INFO - 'tests': ['tp5n']}, 11:39:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:58 INFO - 'talos_options': ['--xperf_path', 11:39:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:58 INFO - 'tests': ['tp5n']}}, 11:39:58 INFO - 'talos.zip': {'path': '', 11:39:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:58 INFO - Running post-action listener: _resource_record_post_action 11:39:58 INFO - ##### 11:39:58 INFO - ##### Finished populate-webroot step (success) 11:39:58 INFO - ##### 11:39:58 INFO - ##### 11:39:58 INFO - ##### Running create-virtualenv step. 11:39:58 INFO - ##### 11:39:58 INFO - Running pre-action listener: _resource_record_pre_action 11:39:58 INFO - Running main action method: create_virtualenv 11:39:58 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:58 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:39:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:58 INFO - Using real prefix '/usr' 11:39:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:59 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:01 INFO - Installing pip.................done. 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:01 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:40:01 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:40:01 INFO - Using env: {'DISPLAY': ':0', 11:40:01 INFO - 'HOME': '/home/cltbld', 11:40:01 INFO - 'LANG': 'en_US.UTF-8', 11:40:01 INFO - 'LANGUAGE': 'en_US:en', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MAIL': '/var/mail/cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SHLVL': '1', 11:40:01 INFO - 'TERM': 'linux', 11:40:01 INFO - 'TMOUT': '86400', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - '_': '/tools/buildbot/bin/python'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 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:40:01 INFO - Cleaning up... 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:01 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:40:01 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:40:01 INFO - Using env: {'DISPLAY': ':0', 11:40:01 INFO - 'HOME': '/home/cltbld', 11:40:01 INFO - 'LANG': 'en_US.UTF-8', 11:40:01 INFO - 'LANGUAGE': 'en_US:en', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MAIL': '/var/mail/cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SHLVL': '1', 11:40:01 INFO - 'TERM': 'linux', 11:40:01 INFO - 'TMOUT': '86400', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - '_': '/tools/buildbot/bin/python'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 INFO - Downloading/unpacking psutil>=3.1.1 11:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:01 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:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:03 INFO - Installing collected packages: psutil 11:40:03 INFO - Running setup.py install for psutil 11:40:03 INFO - building 'psutil._psutil_linux' extension 11:40:03 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:40:03 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:40:03 INFO - building 'psutil._psutil_posix' extension 11:40:03 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:40:03 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:40:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:04 INFO - Successfully installed psutil 11:40:04 INFO - Cleaning up... 11:40:04 INFO - Return code: 0 11:40:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:40: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:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:04 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:04 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:40:04 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:40:04 INFO - Using env: {'DISPLAY': ':0', 11:40:04 INFO - 'HOME': '/home/cltbld', 11:40:04 INFO - 'LANG': 'en_US.UTF-8', 11:40:04 INFO - 'LANGUAGE': 'en_US:en', 11:40:04 INFO - 'LOGNAME': 'cltbld', 11:40:04 INFO - 'MAIL': '/var/mail/cltbld', 11:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:04 INFO - 'MOZ_NO_REMOTE': '1', 11:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:04 INFO - 'NO_EM_RESTART': '1', 11:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:04 INFO - 'PWD': '/builds/slave/test', 11:40:04 INFO - 'SHELL': '/bin/bash', 11:40:04 INFO - 'SHLVL': '1', 11:40:04 INFO - 'TERM': 'linux', 11:40:04 INFO - 'TMOUT': '86400', 11:40:04 INFO - 'USER': 'cltbld', 11:40:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:04 INFO - '_': '/tools/buildbot/bin/python'} 11:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:40:04 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:40:04 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:40:04 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:40:04 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:40:04 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:40:04 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:40:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:06 INFO - Installing collected packages: mozsystemmonitor 11:40:06 INFO - Running setup.py install for mozsystemmonitor 11:40:06 INFO - Successfully installed mozsystemmonitor 11:40:06 INFO - Cleaning up... 11:40:06 INFO - Return code: 0 11:40:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:40:06 INFO - Using env: {'DISPLAY': ':0', 11:40:06 INFO - 'HOME': '/home/cltbld', 11:40:06 INFO - 'LANG': 'en_US.UTF-8', 11:40:06 INFO - 'LANGUAGE': 'en_US:en', 11:40:06 INFO - 'LOGNAME': 'cltbld', 11:40:06 INFO - 'MAIL': '/var/mail/cltbld', 11:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:06 INFO - 'MOZ_NO_REMOTE': '1', 11:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:06 INFO - 'NO_EM_RESTART': '1', 11:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:06 INFO - 'PWD': '/builds/slave/test', 11:40:06 INFO - 'SHELL': '/bin/bash', 11:40:06 INFO - 'SHLVL': '1', 11:40:06 INFO - 'TERM': 'linux', 11:40:06 INFO - 'TMOUT': '86400', 11:40:06 INFO - 'USER': 'cltbld', 11:40:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:06 INFO - '_': '/tools/buildbot/bin/python'} 11:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:06 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:08 INFO - warning: no files found matching '*.txt' 11:40:08 INFO - no previously-included directories found matching 'build' 11:40:08 INFO - no previously-included directories found matching 'dist' 11:40:08 INFO - no previously-included directories found matching '.git*' 11:40:08 INFO - Installing collected packages: jsonschema, functools32 11:40:08 INFO - Running setup.py install for functools32 11:40:08 INFO - warning: no files found matching '*.txt' 11:40:08 INFO - no previously-included directories found matching 'build' 11:40:08 INFO - no previously-included directories found matching 'dist' 11:40:08 INFO - no previously-included directories found matching '.git*' 11:40:08 INFO - Successfully installed jsonschema functools32 11:40:08 INFO - Cleaning up... 11:40:08 INFO - Return code: 0 11:40:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:40:08 INFO - Using env: {'DISPLAY': ':0', 11:40:08 INFO - 'HOME': '/home/cltbld', 11:40:08 INFO - 'LANG': 'en_US.UTF-8', 11:40:08 INFO - 'LANGUAGE': 'en_US:en', 11:40:08 INFO - 'LOGNAME': 'cltbld', 11:40:08 INFO - 'MAIL': '/var/mail/cltbld', 11:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:08 INFO - 'MOZ_NO_REMOTE': '1', 11:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:08 INFO - 'NO_EM_RESTART': '1', 11:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:08 INFO - 'PWD': '/builds/slave/test', 11:40:08 INFO - 'SHELL': '/bin/bash', 11:40:08 INFO - 'SHLVL': '1', 11:40:08 INFO - 'TERM': 'linux', 11:40:08 INFO - 'TMOUT': '86400', 11:40:08 INFO - 'USER': 'cltbld', 11:40:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:08 INFO - '_': '/tools/buildbot/bin/python'} 11:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:09 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:40:09 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:40:09 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:40:09 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:40:09 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:40:09 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:40:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40: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:40: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:40: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:40: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:40: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:40: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:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40: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:40: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:40: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:40: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:40: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:40: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:40:11 INFO - Downloading docopt-0.6.1.tar.gz 11:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:11 INFO - Running setup.py install for blobuploader 11:40:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:11 INFO - Running setup.py install for requests 11:40:12 INFO - Running setup.py install for docopt 11:40:12 INFO - Successfully installed blobuploader requests docopt 11:40:12 INFO - Cleaning up... 11:40:12 INFO - Return code: 0 11:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:12 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:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:12 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:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:12 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:12 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:40:12 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:40:12 INFO - Using env: {'DISPLAY': ':0', 11:40:12 INFO - 'HOME': '/home/cltbld', 11:40:12 INFO - 'LANG': 'en_US.UTF-8', 11:40:12 INFO - 'LANGUAGE': 'en_US:en', 11:40:12 INFO - 'LOGNAME': 'cltbld', 11:40:12 INFO - 'MAIL': '/var/mail/cltbld', 11:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:12 INFO - 'MOZ_NO_REMOTE': '1', 11:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:12 INFO - 'NO_EM_RESTART': '1', 11:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:12 INFO - 'PWD': '/builds/slave/test', 11:40:12 INFO - 'SHELL': '/bin/bash', 11:40:12 INFO - 'SHLVL': '1', 11:40:12 INFO - 'TERM': 'linux', 11:40:12 INFO - 'TMOUT': '86400', 11:40:12 INFO - 'USER': 'cltbld', 11:40:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:12 INFO - '_': '/tools/buildbot/bin/python'} 11:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:12 INFO - Running setup.py (path:/tmp/pip-V55yST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:12 INFO - Running setup.py (path:/tmp/pip-b5pK7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:12 INFO - Running setup.py (path:/tmp/pip-0Afsm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:12 INFO - Running setup.py (path:/tmp/pip-VlSrEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:12 INFO - Running setup.py (path:/tmp/pip-Vc3IEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:12 INFO - Running setup.py (path:/tmp/pip-nR0GdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:13 INFO - Running setup.py (path:/tmp/pip-Fjg3sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:13 INFO - Running setup.py (path:/tmp/pip-PJbCZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:13 INFO - Running setup.py (path:/tmp/pip-Ycl9CF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:13 INFO - Running setup.py (path:/tmp/pip-XjWqgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:13 INFO - Running setup.py (path:/tmp/pip-Yhr8gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:13 INFO - Running setup.py (path:/tmp/pip-AJAB0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:13 INFO - Running setup.py (path:/tmp/pip-g90uuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:13 INFO - Running setup.py (path:/tmp/pip-KUsBl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:13 INFO - Running setup.py (path:/tmp/pip-5mQSgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:13 INFO - Running setup.py (path:/tmp/pip-1etbok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:13 INFO - Running setup.py (path:/tmp/pip-HTfqIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:13 INFO - Running setup.py install for manifestparser 11:40:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:13 INFO - Running setup.py install for mozcrash 11:40:14 INFO - Running setup.py install for mozdebug 11:40:14 INFO - Running setup.py install for mozdevice 11:40:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for mozfile 11:40:14 INFO - Running setup.py install for mozhttpd 11:40:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for mozinfo 11:40:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for mozInstall 11:40:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for mozleak 11:40:14 INFO - Running setup.py install for mozlog 11:40:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for moznetwork 11:40:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:14 INFO - Running setup.py install for mozprocess 11:40:15 INFO - Running setup.py install for mozprofile 11:40:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:15 INFO - Running setup.py install for mozrunner 11:40:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:15 INFO - Running setup.py install for mozscreenshot 11:40:15 INFO - Running setup.py install for moztest 11:40:15 INFO - Running setup.py install for mozversion 11:40:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:15 INFO - Cleaning up... 11:40:15 INFO - Return code: 0 11:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40: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:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:15 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:15 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:40:15 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:40:15 INFO - Using env: {'DISPLAY': ':0', 11:40:15 INFO - 'HOME': '/home/cltbld', 11:40:15 INFO - 'LANG': 'en_US.UTF-8', 11:40:15 INFO - 'LANGUAGE': 'en_US:en', 11:40:15 INFO - 'LOGNAME': 'cltbld', 11:40:15 INFO - 'MAIL': '/var/mail/cltbld', 11:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:15 INFO - 'MOZ_NO_REMOTE': '1', 11:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:15 INFO - 'NO_EM_RESTART': '1', 11:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:15 INFO - 'PWD': '/builds/slave/test', 11:40:15 INFO - 'SHELL': '/bin/bash', 11:40:15 INFO - 'SHLVL': '1', 11:40:15 INFO - 'TERM': 'linux', 11:40:15 INFO - 'TMOUT': '86400', 11:40:15 INFO - 'USER': 'cltbld', 11:40:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:15 INFO - '_': '/tools/buildbot/bin/python'} 11:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:15 INFO - Running setup.py (path:/tmp/pip-3hszYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:15 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:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:15 INFO - Running setup.py (path:/tmp/pip-of6Qbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:15 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:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:15 INFO - Running setup.py (path:/tmp/pip-9NHXKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:16 INFO - Running setup.py (path:/tmp/pip-KXEbe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:16 INFO - Running setup.py (path:/tmp/pip-wghIRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:16 INFO - Running setup.py (path:/tmp/pip-c1GPja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:16 INFO - Running setup.py (path:/tmp/pip-dsri74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:16 INFO - Running setup.py (path:/tmp/pip-p38nHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:16 INFO - Running setup.py (path:/tmp/pip-2c7GJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:16 INFO - Running setup.py (path:/tmp/pip-jDrlBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:16 INFO - Running setup.py (path:/tmp/pip-otULFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:16 INFO - Running setup.py (path:/tmp/pip-oL93Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:16 INFO - Running setup.py (path:/tmp/pip-p24OMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:16 INFO - Running setup.py (path:/tmp/pip-4mZlRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:16 INFO - Running setup.py (path:/tmp/pip-SOMl2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:16 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:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:16 INFO - Running setup.py (path:/tmp/pip-F2pb7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:17 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:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:17 INFO - Running setup.py (path:/tmp/pip-LnjqHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:17 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:40:17 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:40:17 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:40:17 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:40:17 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:40:17 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:40:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40: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:40: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:40: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:40: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:40: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:40: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:40:18 INFO - Downloading blessings-1.6.tar.gz 11:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:19 INFO - Installing collected packages: blessings 11:40:19 INFO - Running setup.py install for blessings 11:40:19 INFO - Successfully installed blessings 11:40:19 INFO - Cleaning up... 11:40:19 INFO - Return code: 0 11:40:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:19 INFO - Reading from file tmpfile_stdout 11:40:19 INFO - Current package versions: 11:40:19 INFO - argparse == 1.2.1 11:40:19 INFO - blessings == 1.6 11:40:19 INFO - blobuploader == 1.2.4 11:40:19 INFO - docopt == 0.6.1 11:40:19 INFO - functools32 == 3.2.3-2 11:40:19 INFO - jsonschema == 2.5.1 11:40:19 INFO - manifestparser == 1.1 11:40:19 INFO - mozInstall == 1.12 11:40:19 INFO - mozcrash == 0.17 11:40:19 INFO - mozdebug == 0.1 11:40:19 INFO - mozdevice == 0.48 11:40:19 INFO - mozfile == 1.2 11:40:19 INFO - mozhttpd == 0.7 11:40:19 INFO - mozinfo == 0.9 11:40:19 INFO - mozleak == 0.1 11:40:19 INFO - mozlog == 3.2 11:40:19 INFO - moznetwork == 0.27 11:40:19 INFO - mozprocess == 0.22 11:40:19 INFO - mozprofile == 0.28 11:40:19 INFO - mozrunner == 6.11 11:40:19 INFO - mozscreenshot == 0.1 11:40:19 INFO - mozsystemmonitor == 0.3 11:40:19 INFO - moztest == 0.7 11:40:19 INFO - mozversion == 1.4 11:40:19 INFO - psutil == 3.1.1 11:40:19 INFO - requests == 1.2.3 11:40:19 INFO - wsgiref == 0.1.2 11:40:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 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 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:19 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:40:19 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:40:19 INFO - Using env: {'DISPLAY': ':0', 11:40:19 INFO - 'HOME': '/home/cltbld', 11:40:19 INFO - 'LANG': 'en_US.UTF-8', 11:40:19 INFO - 'LANGUAGE': 'en_US:en', 11:40:19 INFO - 'LOGNAME': 'cltbld', 11:40:19 INFO - 'MAIL': '/var/mail/cltbld', 11:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:19 INFO - 'MOZ_NO_REMOTE': '1', 11:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:19 INFO - 'NO_EM_RESTART': '1', 11:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:19 INFO - 'PWD': '/builds/slave/test', 11:40:19 INFO - 'SHELL': '/bin/bash', 11:40:19 INFO - 'SHLVL': '1', 11:40:19 INFO - 'TERM': 'linux', 11:40:19 INFO - 'TMOUT': '86400', 11:40:19 INFO - 'USER': 'cltbld', 11:40:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:19 INFO - '_': '/tools/buildbot/bin/python'} 11:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 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:40:19 INFO - Cleaning up... 11:40:19 INFO - Return code: 0 11:40:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:40:19 INFO - Using env: {'DISPLAY': ':0', 11:40:19 INFO - 'HOME': '/home/cltbld', 11:40:19 INFO - 'LANG': 'en_US.UTF-8', 11:40:19 INFO - 'LANGUAGE': 'en_US:en', 11:40:19 INFO - 'LOGNAME': 'cltbld', 11:40:19 INFO - 'MAIL': '/var/mail/cltbld', 11:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:19 INFO - 'MOZ_NO_REMOTE': '1', 11:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:19 INFO - 'NO_EM_RESTART': '1', 11:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:19 INFO - 'PWD': '/builds/slave/test', 11:40:19 INFO - 'SHELL': '/bin/bash', 11:40:19 INFO - 'SHLVL': '1', 11:40:19 INFO - 'TERM': 'linux', 11:40:19 INFO - 'TMOUT': '86400', 11:40:19 INFO - 'USER': 'cltbld', 11:40:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:19 INFO - '_': '/tools/buildbot/bin/python'} 11:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:19 INFO - Cleaning up... 11:40:19 INFO - Return code: 0 11:40:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbce2e61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1337190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', '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:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:40:19 INFO - Using env: {'DISPLAY': ':0', 11:40:19 INFO - 'HOME': '/home/cltbld', 11:40:19 INFO - 'LANG': 'en_US.UTF-8', 11:40:19 INFO - 'LANGUAGE': 'en_US:en', 11:40:19 INFO - 'LOGNAME': 'cltbld', 11:40:19 INFO - 'MAIL': '/var/mail/cltbld', 11:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:19 INFO - 'MOZ_NO_REMOTE': '1', 11:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:19 INFO - 'NO_EM_RESTART': '1', 11:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:19 INFO - 'PWD': '/builds/slave/test', 11:40:19 INFO - 'SHELL': '/bin/bash', 11:40:19 INFO - 'SHLVL': '1', 11:40:19 INFO - 'TERM': 'linux', 11:40:19 INFO - 'TMOUT': '86400', 11:40:19 INFO - 'USER': 'cltbld', 11:40:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:19 INFO - '_': '/tools/buildbot/bin/python'} 11:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:20 INFO - Downloading/unpacking flake8 11:40: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:40: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:40: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:40: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:40: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:40: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:40:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:40:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:40: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:40: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:40: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:40: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:40: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:40: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:40:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:40:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:22 INFO - no previously-included directories found matching 'docs/_build' 11:40:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:40:22 INFO - Running setup.py install for pep8 11:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:22 INFO - no previously-included directories found matching 'docs/_build' 11:40:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:40:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:40:22 INFO - Cleaning up... 11:40:22 INFO - Return code: 0 11:40:22 INFO - Running post-action listener: _resource_record_post_action 11:40:22 INFO - Running post-action listener: _start_resource_monitoring 11:40:22 INFO - Starting resource monitoring. 11:40:22 INFO - ##### 11:40:22 INFO - ##### Finished create-virtualenv step (success) 11:40:22 INFO - ##### 11:40:22 INFO - ##### 11:40:22 INFO - ##### Running install step. 11:40:22 INFO - ##### 11:40:22 INFO - Running pre-action listener: _resource_record_pre_action 11:40:22 INFO - Running main action method: install 11:40:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:23 INFO - Reading from file tmpfile_stdout 11:40:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:23 INFO - Reading from file tmpfile_stdout 11:40:23 INFO - Output received: 11:40:23 INFO - Usage: mozinstall [options] installer 11:40:23 INFO - Options: 11:40:23 INFO - -h, --help show this help message and exit 11:40:23 INFO - -d DEST, --destination=DEST 11:40:23 INFO - Directory to install application into. [default: 11:40:23 INFO - "/builds/slave/test"] 11:40:23 INFO - --app=APP Application being installed. [default: firefox] 11:40:23 INFO - mkdir: /builds/slave/test/build/application 11:40:23 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:40:23 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:40:40 INFO - Reading from file tmpfile_stdout 11:40:40 INFO - Output received: 11:40:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:40:40 INFO - Running post-action listener: _resource_record_post_action 11:40:40 INFO - ##### 11:40:40 INFO - ##### Finished install step (success) 11:40:40 INFO - ##### 11:40:40 INFO - ##### 11:40:40 INFO - ##### Running run-tests step. 11:40:40 INFO - ##### 11:40:40 INFO - Running pre-action listener: _resource_record_pre_action 11:40:40 INFO - Running main action method: run_tests 11:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:40 INFO - Python 2.7.3 11:40:40 INFO - Return code: 0 11:40:40 INFO - grabbing minidump binary from tooltool 11:40:40 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:40:40 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 0x13c9110>, '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 0x1335230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13356c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:40 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:40:40 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:40:40 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:40:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:40 INFO - Return code: 0 11:40:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:40:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:40:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:40:41 INFO - Return code: 0 11:40:41 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-022', '--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:40:41 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-022 --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:40:41 INFO - Using env: {'DISPLAY': ':0', 11:40:41 INFO - 'HOME': '/home/cltbld', 11:40:41 INFO - 'LANG': 'en_US.UTF-8', 11:40:41 INFO - 'LANGUAGE': 'en_US:en', 11:40:41 INFO - 'LOGNAME': 'cltbld', 11:40:41 INFO - 'MAIL': '/var/mail/cltbld', 11:40:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:41 INFO - 'MOZ_NO_REMOTE': '1', 11:40:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:41 INFO - 'NO_EM_RESTART': '1', 11:40:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:41 INFO - 'PWD': '/builds/slave/test', 11:40:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:41 INFO - 'SHELL': '/bin/bash', 11:40:41 INFO - 'SHLVL': '1', 11:40:41 INFO - 'TERM': 'linux', 11:40:41 INFO - 'TMOUT': '86400', 11:40:41 INFO - 'USER': 'cltbld', 11:40:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257', 11:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:41 INFO - '_': '/tools/buildbot/bin/python'} 11:40:41 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-022', '--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:40:41 INFO - mozversion application_buildid: 20160606083115 11:40:41 INFO - mozversion application_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:40:41 INFO - mozversion application_display_name: Nightly 11:40:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:41 INFO - mozversion application_name: Firefox 11:40:41 INFO - mozversion application_remotingname: firefox 11:40:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:40:41 INFO - mozversion application_vendor: Mozilla 11:40:41 INFO - mozversion application_version: 49.0a1 11:40:41 INFO - mozversion platform_buildid: 20160606083115 11:40:41 INFO - mozversion platform_changeset: 8ee8066ffeea90aabada756a2126349680bccb37 11:40:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:40:41 INFO - mozversion platform_version: 49.0a1 11:40:41 INFO - using testdate: 1465238441 11:40:41 INFO - actual date: 1465238441 11:40:41 INFO - starting webserver on 'localhost:38950' 11:40:41 INFO - SUITE-START | Running 2 tests 11:40:41 INFO - TEST-START | dromaeo_css 11:40:41 INFO - operating with platform_type : linux_ 11:40:41 INFO - Initialising browser for dromaeo_css test... 11:40:41 INFO - TEST-INFO | started process 31274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUpeFQ/profile http://localhost:38950/getInfo.html) 11:40:46 INFO - PROCESS | 31274 | __metrics Screen width/height:1600/1200 11:40:46 INFO - PROCESS | 31274 | colorDepth:24 11:40:46 INFO - PROCESS | 31274 | Browser inner width/height: 1024/697 11:40:46 INFO - PROCESS | 31274 | __metrics 11:40:46 ERROR - PROCESS | 31274 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 11:40:47 INFO - TEST-INFO | 31274: exit 0 11:40:47 INFO - Browser initialized. 11:40:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:47 INFO - TEST-INFO | started process 31393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUpeFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:59 INFO - PROCESS | 31393 | RSS: Main: 167579648 11:40:59 INFO - PROCESS | 31393 | 11:41:49 INFO - PROCESS | 31393 | 1465238509180 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:43:56 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38950/tests/dromaeo/cssquery-ext.html) 11:43:57 INFO - PROCESS | 31393 | RSS: Main: 170733568 11:43:57 INFO - PROCESS | 31393 | 11:46:59 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-ext.html (next: http://localhost:38950/tests/dromaeo/cssquery-jquery.html) 11:47:00 INFO - PROCESS | 31393 | RSS: Main: 170164224 11:47:00 INFO - PROCESS | 31393 | 11:50:02 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38950/tests/dromaeo/cssquery-mootools.html) 11:50:02 INFO - PROCESS | 31393 | RSS: Main: 171372544 11:50:02 INFO - PROCESS | 31393 | 11:53:04 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38950/tests/dromaeo/cssquery-prototype.html) 11:53:05 INFO - PROCESS | 31393 | RSS: Main: 168452096 11:53:05 INFO - PROCESS | 31393 | 11:56:07 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38950/tests/dromaeo/cssquery-yui.html) 11:56:08 INFO - PROCESS | 31393 | RSS: Main: 170590208 11:56:08 INFO - PROCESS | 31393 | 11:59:10 INFO - PROCESS | 31393 | Cycle 1(1): loaded http://localhost:38950/tests/dromaeo/cssquery-yui.html (next: http://localhost:38950/tests/dromaeo/cssquery-dojo.html) 11:59:11 INFO - PROCESS | 31393 | RSS: Main: 171786240 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | __start_tp_report 11:59:11 INFO - PROCESS | 31393 | _x_x_mozilla_page_load 11:59:11 INFO - PROCESS | 31393 | _x_x_mozilla_page_load_details 11:59:11 INFO - PROCESS | 31393 | |i|pagename|runs| 11:59:11 INFO - PROCESS | 31393 | |0;dojo.html;3128.421242070217;3149.3543823516184;3160.383725173589;3177.8252196129206;3199.9680003199974;5418.485243901828;5467.835964921053;5495.038368285549;5580.748866301016;5607.551395888329;5380.381256155543;5474.288342515468;5475.425080366564;5482.80810171644;5537.197106419577;4950.826721064773;4987.426445958725;5077.959018401238;5107.38711354638;5162.5095615916425;582.7271320229063;4905.533974272438;4987.551120399164;5031.993601279741;5059.392872855263;5009.298698182258;5015.52352526513;5043.974780126095;5059.443461219263;5063.215201643733;5046.26829109777;5046.899062018739;5050.873728156789;5065.670731402484;5080.415752188509;4918.606511479073;4929.65492415531;5003.324551185616;5023.974880125576;5048.040872234264;5434.429384914567;5453.836384908459;5499.395066542677;5533.501984821345;5579.442055794429;5725.341585717654;5797.594168408213;5918.8816223675285;5970.194023806774;5992.490638295706;5921.378255283219;5974.761009559613;5977.163197152402;5992.9700351498395;6068.726907289182;5564.360098588633;5566.693831839248;5571.052921003439;5571.331440227199;5582.302212223472;5921.73352199152;6063.333033366326;6086.786962456293;6116.418940200674;6117.969410153009;5918.171455996164;5918.852028699317;5929;5930.140129681172;5962.016267315931;6002.909956350658;6006.759729610767;6015.909761353583;6018.668973206516;6034;5670.092785154356;5846.4153584642045;5895.882082358329;5911.113333000085;5982.611130276518;5826.592138550261;5903.35063143054;5913.2608423947;5931.9406805931385;5965.821025369246;4467.30756732707;4478.171538265431;4483.349914262479;4497.482789479186;4498.775061246924;3887.8833634990997;3895.454636350913;3960.683145348365;3998.2203470323007;4022.135240923157;5649.519790817744;5653.943460565341;5656.434356564393;5683.715814209356;5693.202951586781;5995.070764031582;6014.36849130835;6048.727807248684;6074.665893375906;6076.665783381868;5519.530839878575;5628.831135065954;5632.633878797865;5686.545076393879;5687.175359572839;5086.898262034739;5119.59043276537;5128.230765385222;5131.332926719577;5148.0476111919415;5995.820125396158;6156.322804491502;6181.938180618136;6182.876342473215;6203.379662033761;5916.230889984275;5950.85122871923;5957.106434034929;5982.551308651781;5988.251468566429;6154.784582539769;6155.692215389123;6162.722677479434;6162.784302549389;6189.535784816067;5711.086226203787;5714.571407144564;5862.706864656665;5866.178734977021;5898.7935422261735;6021.849453763691;6072.362401947732;6074.483668888194;6088.208532890696;6107.5724699272405;5858.531317494675;5910;5922.5261979040715;5932.377100404568;5959.731812068554;5640.956423061747;5786.479216870502;5922.170896074467;5935.910961335497;5940.554458415722;5699.971500142638;5724.856878578069;5749.396313387034;5776.451237132634;5809.360970293349;5855.473007429352;5856.765729370777;5861.648301101947;5880.14737863016;5896.14505896634;5514.6691198528215;5708.743106560298;5746.9712651436475;5769.1634712967225;5775.249217601685 11:59:11 INFO - PROCESS | 31393 | |1;ext.html;562.600553606939;610.2311088029084;611.9632822030676;627.5920651576477;645.7062036773268;40715.59284407155;42245.57754422455;42463.78768106163;42704.35943460851;42742.358864617054;43410;44095.77952110243;44124.338134928;44191.33712994308;44288;8671.30629549636;8813.515256660881;8858.73423797287;8873.245774109177;8888.555572221396;8689.131086891324;8716.477011379338;8763.342749293828;8768.210861022506;8775.254103401187;8768.298536117096;8783.253423458982;8822.867656985118;8830.823383532326;8831.337649676268;8706.695265665734;8721.60752766127;8743.213110820025;8803.119688031178;8823.07357727439;8507.489550626982;8655.870161947576;8661.783455413602;8664.696735614287;8682;40349;40664.593354066375;40674.59325406767;40703.18593628141;40892.79553602243;3519.278547897675;3593.6406359364114;3595.209054008114;3617.620149884277;4054.452648892391;32002.359952801045;32280.838595806872;32478;33073.173170670685;33892.152696182544;4283.550227226158;4353.912921741579;4374.518802931675;4375.16871794358;4394.582514661102;256860;257210.99999999814;257610;257846;258785;34687.479687804705;57818;59504.70247648821;59505.70247148736;59571;34684;37259;37384.81307593499;37412;37450.62549374526;15395.3072111753;15484.148371839432;15669.138197399025;15671.451499197474;15684.92157539205;12953.740925181444;12960.157589756636;12973.221606703628;12996.48014079445;13001.349932503337;8336.249737523653;8348.874766878502;8354.122817104238;8443.577821109044;8445.366597505212;3229.935401291961;3278.508223766454;3291.8518666660057;3293.094399040235;3329.167708072982;1029.1766586730585;1053.1732589916878;1056.2078441169124;1064.2443864856039;1173.7887180307455;32564.34871302608;32782.67217327796;32861.3427731444;32939.83530082382;33355.666443335256;1120.42858142348;1131.3833960491552;1145.204083162211;1229.4037391864938;1243.210561293585;16797.916010420115;17020.744688829676;17107.74338384925;17213;17566.736498952527;567855.5715542746;569228;571734;573340;574272;59366.406335936954;59915.70042149761;60412.09381859276;60452.69773651192;60532.394676053555;1357.9524716635067;1423.323921137472;1427.664498842771;1434.4538444261311;1439.172475826404;31087.378252435275;31855.840720797176;32046.83976580102;32424.35151297008;32445.51331729979;50421.74789126031;50517.242241367145;50970.74514627403;51178.97642047213;51286.48713512966;443929;458463;458641;459640;462676;27137.1858844235;27416.314592135357;27730;27938.72061279361;28040.57939130874;48208.758956205;48301.27548086852;48557;49713;49758.50241497539;40015.39976900407;40910;41473.585264148176;42167.789161055225;42784.786076069424;41538.37692434555;41886.79056604698;42036.159276814906;42404.36393454162;42805.78597106995;41327;41613;42360.364594531726;42492;44676.77661611671;33537.832310839265;36619;37931.810340949225;40390;40658.79670601628;28787.568186477638;28829.279268017628;28992.42015159727;29027.854860726406;29039 11:59:11 INFO - PROCESS | 31393 | |2;jquery.html;378.9068537269976;387.60851539944656;387.9806009699514;389.5597974289053;409.1653027823241;18110.456686299414;19531.218751249933;19583.314583989526;19744;19834.30579929701;18651.1606977686;18772;19001.904990475065;19229.038548072574;19508.122134503945;5523.475269849358;5591.1054231323;5629.887402251952;5639.436056394348;5710.314762228539;5518.117101263799;5527.723613819313;5634.647684555697;5657.434256574351;5664.886702265972;5439.428859969706;5618.381977982419;5667.546596272309;5677.943220567783;5770.134479828039;5764.308283006024;5784.363719990798;5798.275215598051;5803.82588522345;5814.563907706918;5500.064988951888;5630.408807075239;5668.291463567054;5687.203791469197;5699.2306038684665;13936.651583710387;13966.231857247847;14009.71980560383;20237.291694790612;22771.31686049421;2234.9888250558806;2347.7886990170796;2486.987565062163;2647.2455350225287;2904.19146813084;9655.855162172573;10268.229882758824;10463.581456741722;10513.737156571071;10827.350358978487;1849.704047352417;1854.9721754173697;1906.752122224116;1916.5400303926958;1954.4722924810364;64353.3564664352;73818.26181738167;76191.61904190555;81839;85577.14422855755;10786.298890572089;11044.392558409365;11065.446727663584;11072.726636436913;11285.37930413835;15553.377864885504;15612.29744661493;15624.218789060502;15640.843591564166;15658.217089145497;8057.35541156706;8174.877376839352;8178.713745018896;8255.463394879314;8415.789605259917;7955.801104972306;7995.960020199862;8044.798880028046;8172.141925097898;8192.221738934792;4085.9182816343505;4247.596478334615;4466.285394336891;4589.632829373709;4835.178019736653;1899.3637131560806;1909.8281154696144;1952.1020330647777;1964.135780256711;2019.1923230707835;879.1077056787366;999.7000899730052;1021.6066814276558;1037.1029059863165;1039.365986748083;19643.90178049129;19686.212551498065;19940.401787946386;20019.799802002086;20024.89987550053;987.9703608891745;998.6454808543008;1003.9146672532917;1005.1807776661997;1041.234692501011;10478.580856765644;11059.115270778319;11137.498812553455;11216.887831121747;11341.716457088638;516498;526761;528074;529628;531439;84875.5756221215;94551;97112.51443742737;97682;98040.50979745056;979.1383582447401;1052.821020426514;1060.7878424315168;1060.9045185933303;1061.4851796878509;17164.656706866044;17430.389936352167;18303.26786928508;18372.540686482946;18396.632067358845;43694;43875;44435.55564444314;44776;45563;61436;62025.65820392529;62160;63196;63573.36426635859;8291.62687679068;8772;8782.165694259034;8964.865527017231;9019.233365164035;12630.810537841757;13195.736085278433;13285.867141328463;13663.658408539866;13783.104098233583;11543.538258469904;11770.82343764827;11834.567975287415;12161.635150945485;12169.634910952685;11278.774424511628;11510.769784604428;11804.527818887149;11828;12009.519619215134;11991.820122697993;12214.206076604993;12247.510099595916;12274.140810143204;12317.322547259986;8663.913360866563;8681.392302538761;8701.738947831574;8756.38705290649;8837.602307896288;9178.311626627896;11570;11620.012298954345;12123.575674851338;12192.207506512048 11:59:11 INFO - PROCESS | 31393 | |3;mootools.html;1524.4207201263519;1528.1976962094898;1681.2098313792521;1819.1540933465935;1825.8082901295356;7812.3750099992;8589.441686290402;8674.392792504526;9192.310576706748;9196.218321442677;8245.340372770179;8349.248567628912;8492.957535212316;8494.532800695959;8576.614052367642;2274.692916456282;2351.9886448826996;2355.422921384263;2357.6581395697613;2364.0780095762666;2352.306069709431;2359.7050368703913;2387.415083304593;2390.5577468168444;2407.6629271901948;2361.645753137026;2383.7020372453444;2400.015993442689;2413.2157048959157;2421.9394515137087;2280.2361208995007;2289.7824706652923;2299.275728145637;2299.735530414007;2306.1351993002622;2256.4133325335365;2263.2757517594378;2264.6376579747325;2267;2274.6815445837597;8806.383553151281;8886.600102995317;8903.154200350957;8908.465492070432;8941.776455588597;5195.766190521435;5221.242919776649;5347.144456886918;5353.785848566092;5394.109971854639;3446.2418267981;3519.225770330523;3592.6227746086547;3629.1290090378384;3636.5999740028574;1166.650004998497;1191.7199458127334;1197.8382918306093;1221.407617305606;1224.644852992631;12243.32661703606;12525;12530.74938501234;12544.310062946533;12632.74734505314;4493.707908985971;4512.684112112186;4517.796699148546;4554.066416384633;4654.092451971901;10523.263371563917;10554.10290125348;10556.102731267774;10564.788704225872;10576.57693692259;5211.739413029333;5240.423553409122;5307.2569840222395;5315.309009828775;5317.909828485152;4259.637930775919;4804.135255653946;4882.096812089775;4961.727105009187;4969.90060198794;4143.81352839123;4145.958540414617;4215.135897141079;4215.135897141079;4216.219999300078;1267.3283159925254;1282.538286216961;1290.2581015915887;1291.3607764156802;1294.2687381629348;876.8114855306139;967.4243824924159;985.014985014985;1070.71626019105;1074.9677509674723;6258.499320054385;6264.780732674426;6365.3316401778075;6408.935910640927;6597.670116494252;979.3878825733916;984.5667906121283;989.7228775942604;1004.638330201127;1030.5208078243652;4173.561776013536;4218.346156345771;4240.597143271446;4282.379055037064;4300.311950087971;11125.443727813577;11366.09071274296;11408.657740267805;11421.42892855354;11473.770524589461;10879.347239165518;11325.037371823488;11381.772364552662;11409.48657310423;11431.885681143249;8497.447665901696;8566.314694824274;8589.785255368666;8622.353323500762;8642.567871606394;6132.47873930703;6333.145025421693;6370.108184854032;6514.869702606016;6534.83662908412;10487.213458990758;10649;10719.356838589709;10781.838272426077;10784.406857622906;10536.473176341306;10681.51933162994;10860.511276992396;10937.781244374908;11001.889981100087;7236.963815181101;7946.245106714853;8079.474834135997;8136.593170341341;8179.83640327202;8929.910700893168;8935.106489351012;9018.188363047357;9059.048799876182;9083.909160908306;7772.961135194514;7931.167227441036;7954.211478014871;7999.920000799918;8038;7981.680732770624;8022.558759268063;8039.15588863161;8226.506409615442;8241.217084376975;7253.637318133967;7374.483786134919;7378.335949764332;7477.327040566375;7482.326590606872;5122.436531981404;5151.871203219949;5191.636585438983;5195.68825870449;5257;5129.256257842518;5140.6096165283325;5228.215767634885;5312.442193569619;5357.437469065692 11:59:11 INFO - PROCESS | 31393 | |4;prototype.html;308.77150908327843;319.4951975878113;322.4453939224534;322.8047031545915;325.9926826107328;5520.696361700105;5545.195946587743;5587.413321601234;5694.459026392491;5734.111212762024;5594.412586678402;5618.353889302732;5633.380328163898;5640.774369025245;5699.287589051369;4389.62688171505;4392.714473559208;4393.912121757563;4394.516603173664;4416.425864637593;4157.210130075291;4355.237833379162;4358.542353052915;4440.978574927769;4442.178197033559;4304.677149213806;4310.892227694301;4349.369341445488;4352.3471479278205;4366.388705581221;4340.262155433584;4354.628292087982;4361.34579813029;4379.364992076163;4384.05742765307;3736.9439458408146;3753.1555400035045;3826.1582451860545;3838.6929045676557;3841.020539762371;5366.758495867695;5394.352677678665;5409.648372855751;5419.756110975016;5427.213054107172;4913.508649135094;4914.434839993375;4947.777350019258;4949.554540091373;4972.254161875711;5738.626989245686;5816.1566572846705;5859.209006784072;5865.237519122529;5893.58744887858;4093.89765255868;4100.2414553307735;4105.4252404663375;4108.198901214264;4133.8966525836795;6093.756249750005;6096.359882212349;6109.5723299369065;6122.785702500391;6152.692365381758;4044.8179831907046;4180.289350810309;4198.3702444633545;4204.810783514749;4219.156168766259;4246.320588705854;4249.830006799755;4270.274053410928;4294.26997410441;4299.419578356944;4911.386076740408;4920.778564964585;4943.826966056243;4951.702897826142;4965.528274813887;5835.883282334329;5886.6173698709445;5914.852128696731;5958.76164953397;5964.194833697482;1475.638468575206;1481.4370539195038;1490.508132316333;1495.48405800001;1501.2718831366778;872.882160908282;906.0441234497537;917.4495302818256;927.7707038174445;927.9536023198813;5019.171836646912;5039.496050394931;5045.974770126126;5112.335396398519;5143.151380022329;5379.73101344939;5435.483629055233;5438.700871452108;5451.236826844245;5496.615236933376;4769.928451073237;4893.996730670204;5062.7468626568525;5124.9500199919585;5147.433782283946;2868.8709008094684;2872.3824377758883;2879.7696184305205;2935.515639919432;2942.764578833688;5477.534409575231;5484.698341591251;5519.558435325164;5527.226188333637;5528.273326305951;5440.238366628596;5717.857053573611;6224.315325314212;6243.410039227462;6250.656213908279;6302.558820882494;6307.5584709070845;6313.652749098752;6321.55749097568;6340.461060809883;5989.371116032754;6068.8786224276155;6145.631262124287;6155.72299246526;6159.753609855556;6050.606710563799;6058.454739073504;6062.242219722535;6064.241969753781;6072.271327440559;5713.371529131709;6376.39424254695;6379.585326953918;6408.955746020603;6431.488600179047;4205.831766729297;4239.0674051708575;4262.680298977527;4290.742555446684;4294.742315461082;6077.4226448487325;6124.755009799558;6152.569320147547;6218.19163508741;6239.875202495834;5669.659820410789;5922.141289512911;5935.970320148372;5999.880002400015;6015.879682406415;5868.122200895672;5881.2942446906645;5944.970275148769;5955.553333499918;5955.76176952917;5836.548649567107;5845.620034697731;5855.214159681338;5870.618409803349;5872.207252020922;5674.631148975303;5992.194956202756;5998.970005149947;6003.81988540327;6007.639541627516;5887.146363777314;5929.584929055098;5931.436513531207;5942.851428714317;5949.553783466344 11:59:11 INFO - PROCESS | 31393 | |5;yui.html;758.3705524414736;765.8889461028149;781.1251398433751;799.3365506629498;801.8676918308475;15520.379184832607;16182.514524564252;16421.753673694875;16500.25748841302;16525.504234872944;14957.551273461786;15006.249687515636;15027.121609798774;15029.098254104762;15068.32192551335;673.1921693967234;786.1705900275207;796.3509739562253;802.9839403211932;804.6660635836121;774.8527779721863;775.244136966456;782.4913806026071;784.1100351101512;784.9725259615915;829.6971605364029;834.7620928035511;837.6774941647479;837.9664813407487;840.7267638017669;833.4707460762398;833.6373677450268;835.5195762436593;835.6949713354612;838.1576515601812;597.9013462778636;601.287474342905;601.8104297146385;601.8344955137328;604.3956043956044;15119.16844573548;15129.848701512954;15210.543683689508;15219.467318643794;15219.543413697496;14295.285235738276;15198;15246.771298430533;15354;15357.232138393036;11543.711407214887;11623.709407264885;11636.476358563885;11765.294082355085;12206.633800985985;3701.481792549045;3859.9807000964815;3972.6226008529143;4055.7566546007333;4067.5729048449784;79467.6026619869;80172.19827801705;80433.59783201104;80805.59597202035;82499.5875020627;10300.484975751182;10305.639302624371;10893.891061089445;11112.222144449972;11145.442727863574;16992.490225293262;17049.91475042642;17183.484495465156;17222.483325500256;17229.827701723072;7732.226777322223;7801.6879324827505;7936.365090792723;7959.880601790977;8037.557934313552;4536.9092618148115;4571.291449825282;4643.187442197602;4684.4378674559275;4756.714597124114;3435.793852368866;3524.7356448266482;3526.4710293456187;3533.5406397168717;3537.663921927413;626.0827887145354;635.5678138865616;638.1894993358502;643.8744444833212;705.104517263073;660.1747815230962;704.3414407528977;748.098541257783;754.9962250188714;763.5952944939191;10375.16998640107;10497.790044199073;10527.94736026315;10549.156067514581;10783.46082695862;707.8018154916632;725.7677543186236;746.5931067568189;749.8912657664608;769.3768047881234;4355.412019377407;4433.645308375322;4506.59440650343;4522.570355816258;4739.075880203396;98302.50848745853;100924;102433;112410.43794780974;117511.41244293723;64959.350406496276;73190.63404682942;95718.52140739252;101105.49447252716;101280.49359753302;87830.56084719663;89036;89791;91322.54338728264;91382.08617913869;9381.624735010522;9502.572384242587;9507.096825801538;9665.226781857575;9677.419354838732;49257;49932.750336248086;50710.746446267534;51205.48794512007;52368.16711415082;45350.54649453463;45383.773081134386;75217.36739214101;78954.6052269735;79193.20806792089;13157;13195.670108246986;13251.867481325064;13570.660733481742;13874.791878122038;14422.639434014234;14890.627734306729;15053.247337633293;15359.61600959985;15470.613234669223;14262.215578143301;14267.857321426653;14507;14522.20127892976;14783.704325913206;13897.722045559234;14074.225917574222;14074.859251407355;14158;14376.348683883198;13274.734505309647;13842.792358114435;13907.096038757449;13982.300884955916;14087.366068526735;11225.550977960791;11255.493502792559;11380.886191138314;11571.56598404145;11584.189106762446;11491.655250342503;11540.596079137189;11577.768444631229;11821.23161994502;12067.81898271509 11:59:11 INFO - PROCESS | 31393 | __end_tp_report 11:59:11 INFO - PROCESS | 31393 | __start_cc_report 11:59:11 INFO - PROCESS | 31393 | _x_x_mozilla_cycle_collect,346 11:59:11 INFO - PROCESS | 31393 | __end_cc_report 11:59:11 INFO - PROCESS | 31393 | __startTimestamp1465239551198__endTimestamp 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | ------- Summary: start ------- 11:59:11 INFO - PROCESS | 31393 | Number of tests: 6 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#0] dojo.html Cycles:165 Average:5492.59 Median:5725.34 stddev:758.20 (13.2%) stddev-sans-first:737.49 11:59:11 INFO - PROCESS | 31393 | Values: 3128.4 3149.4 3160.4 3177.8 3200.0 5418.5 5467.8 5495.0 5580.7 5607.6 5380.4 5474.3 5475.4 5482.8 5537.2 4950.8 4987.4 5078.0 5107.4 5162.5 582.7 4905.5 4987.6 5032.0 5059.4 5009.3 5015.5 5044.0 5059.4 5063.2 5046.3 5046.9 5050.9 5065.7 5080.4 4918.6 4929.7 5003.3 5024.0 5048.0 5434.4 5453.8 5499.4 5533.5 5579.4 5725.3 5797.6 5918.9 5970.2 5992.5 5921.4 5974.8 5977.2 5993.0 6068.7 5564.4 5566.7 5571.1 5571.3 5582.3 5921.7 6063.3 6086.8 6116.4 6118.0 5918.2 5918.9 5929.0 5930.1 5962.0 6002.9 6006.8 6015.9 6018.7 6034.0 5670.1 5846.4 5895.9 5911.1 5982.6 5826.6 5903.4 5913.3 5931.9 5965.8 4467.3 4478.2 4483.3 4497.5 4498.8 3887.9 3895.5 3960.7 3998.2 4022.1 5649.5 5653.9 5656.4 5683.7 5693.2 5995.1 6014.4 6048.7 6074.7 6076.7 5519.5 5628.8 5632.6 5686.5 5687.2 5086.9 5119.6 5128.2 5131.3 5148.0 5995.8 6156.3 6181.9 6182.9 6203.4 5916.2 5950.9 5957.1 5982.6 5988.3 6154.8 6155.7 6162.7 6162.8 6189.5 5711.1 5714.6 5862.7 5866.2 5898.8 6021.8 6072.4 6074.5 6088.2 6107.6 5858.5 5910.0 5922.5 5932.4 5959.7 5641.0 5786.5 5922.2 5935.9 5940.6 5700.0 5724.9 5749.4 5776.5 5809.4 5855.5 5856.8 5861.6 5880.1 5896.1 5514.7 5708.7 5747.0 5769.2 5775.2 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#1] ext.html Cycles:180 Average:58195.03 Median:41505.98 stddev:119416.99 (287.7%) stddev-sans-first:119673.58 11:59:11 INFO - PROCESS | 31393 | Values: 562.6 610.2 612.0 627.6 645.7 40715.6 42245.6 42463.8 42704.4 42742.4 43410.0 44095.8 44124.3 44191.3 44288.0 8671.3 8813.5 8858.7 8873.2 8888.6 8689.1 8716.5 8763.3 8768.2 8775.3 8768.3 8783.3 8822.9 8830.8 8831.3 8706.7 8721.6 8743.2 8803.1 8823.1 8507.5 8655.9 8661.8 8664.7 8682.0 40349.0 40664.6 40674.6 40703.2 40892.8 3519.3 3593.6 3595.2 3617.6 4054.5 32002.4 32280.8 32478.0 33073.2 33892.2 4283.6 4353.9 4374.5 4375.2 4394.6 256860.0 257211.0 257610.0 257846.0 258785.0 34687.5 57818.0 59504.7 59505.7 59571.0 34684.0 37259.0 37384.8 37412.0 37450.6 15395.3 15484.1 15669.1 15671.5 15684.9 12953.7 12960.2 12973.2 12996.5 13001.3 8336.2 8348.9 8354.1 8443.6 8445.4 3229.9 3278.5 3291.9 3293.1 3329.2 1029.2 1053.2 1056.2 1064.2 1173.8 32564.3 32782.7 32861.3 32939.8 33355.7 1120.4 1131.4 1145.2 1229.4 1243.2 16797.9 17020.7 17107.7 17213.0 17566.7 567855.6 569228.0 571734.0 573340.0 574272.0 59366.4 59915.7 60412.1 60452.7 60532.4 1358.0 1423.3 1427.7 1434.5 1439.2 31087.4 31855.8 32046.8 32424.4 32445.5 50421.7 50517.2 50970.7 51179.0 51286.5 443929.0 458463.0 458641.0 459640.0 462676.0 27137.2 27416.3 27730.0 27938.7 28040.6 48208.8 48301.3 48557.0 49713.0 49758.5 40015.4 40910.0 41473.6 42167.8 42784.8 41538.4 41886.8 42036.2 42404.4 42805.8 41327.0 41613.0 42360.4 42492.0 44676.8 33537.8 36619.0 37931.8 40390.0 40658.8 28787.6 28829.3 28992.4 29027.9 29039.0 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#2] jquery.html Cycles:180 Average:30061.89 Median:2567.12 stddev:86675.90 (3376.4%) stddev-sans-first:86890.39 11:59:11 INFO - PROCESS | 31393 | Values: 378.9 387.6 388.0 389.6 409.2 18110.5 19531.2 19583.3 19744.0 19834.3 18651.2 18772.0 19001.9 19229.0 19508.1 5523.5 5591.1 5629.9 5639.4 5710.3 5518.1 5527.7 5634.6 5657.4 5664.9 5439.4 5618.4 5667.5 5677.9 5770.1 5764.3 5784.4 5798.3 5803.8 5814.6 5500.1 5630.4 5668.3 5687.2 5699.2 13936.7 13966.2 14009.7 20237.3 22771.3 2235.0 2347.8 2487.0 2647.2 2904.2 9655.9 10268.2 10463.6 10513.7 10827.4 1849.7 1855.0 1906.8 1916.5 1954.5 64353.4 73818.3 76191.6 81839.0 85577.1 10786.3 11044.4 11065.4 11072.7 11285.4 15553.4 15612.3 15624.2 15640.8 15658.2 8057.4 8174.9 8178.7 8255.5 8415.8 7955.8 7996.0 8044.8 8172.1 8192.2 4085.9 4247.6 4466.3 4589.6 4835.2 1899.4 1909.8 1952.1 1964.1 2019.2 879.1 999.7 1021.6 1037.1 1039.4 19643.9 19686.2 19940.4 20019.8 20024.9 988.0 998.6 1003.9 1005.2 1041.2 10478.6 11059.1 11137.5 11216.9 11341.7 516498.0 526761.0 528074.0 529628.0 531439.0 84875.6 94551.0 97112.5 97682.0 98040.5 979.1 1052.8 1060.8 1060.9 1061.5 17164.7 17430.4 18303.3 18372.5 18396.6 43694.0 43875.0 44435.6 44776.0 45563.0 61436.0 62025.7 62160.0 63196.0 63573.4 8291.6 8772.0 8782.2 8964.9 9019.2 12630.8 13195.7 13285.9 13663.7 13783.1 11543.5 11770.8 11834.6 12161.6 12169.6 11278.8 11510.8 11804.5 11828.0 12009.5 11991.8 12214.2 12247.5 12274.1 12317.3 8663.9 8681.4 8701.7 8756.4 8837.6 9178.3 11570.0 11620.0 12123.6 12192.2 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#3] mootools.html Cycles:180 Average:5973.29 Median:4503.20 stddev:3408.69 (75.7%) stddev-sans-first:3401.85 11:59:11 INFO - PROCESS | 31393 | Values: 1524.4 1528.2 1681.2 1819.2 1825.8 7812.4 8589.4 8674.4 9192.3 9196.2 8245.3 8349.2 8493.0 8494.5 8576.6 2274.7 2352.0 2355.4 2357.7 2364.1 2352.3 2359.7 2387.4 2390.6 2407.7 2361.6 2383.7 2400.0 2413.2 2421.9 2280.2 2289.8 2299.3 2299.7 2306.1 2256.4 2263.3 2264.6 2267.0 2274.7 8806.4 8886.6 8903.2 8908.5 8941.8 5195.8 5221.2 5347.1 5353.8 5394.1 3446.2 3519.2 3592.6 3629.1 3636.6 1166.7 1191.7 1197.8 1221.4 1224.6 12243.3 12525.0 12530.7 12544.3 12632.7 4493.7 4512.7 4517.8 4554.1 4654.1 10523.3 10554.1 10556.1 10564.8 10576.6 5211.7 5240.4 5307.3 5315.3 5317.9 4259.6 4804.1 4882.1 4961.7 4969.9 4143.8 4146.0 4215.1 4215.1 4216.2 1267.3 1282.5 1290.3 1291.4 1294.3 876.8 967.4 985.0 1070.7 1075.0 6258.5 6264.8 6365.3 6408.9 6597.7 979.4 984.6 989.7 1004.6 1030.5 4173.6 4218.3 4240.6 4282.4 4300.3 11125.4 11366.1 11408.7 11421.4 11473.8 10879.3 11325.0 11381.8 11409.5 11431.9 8497.4 8566.3 8589.8 8622.4 8642.6 6132.5 6333.1 6370.1 6514.9 6534.8 10487.2 10649.0 10719.4 10781.8 10784.4 10536.5 10681.5 10860.5 10937.8 11001.9 7237.0 7946.2 8079.5 8136.6 8179.8 8929.9 8935.1 9018.2 9059.0 9083.9 7773.0 7931.2 7954.2 7999.9 8038.0 7981.7 8022.6 8039.2 8226.5 8241.2 7253.6 7374.5 7378.3 7477.3 7482.3 5122.4 5151.9 5191.6 5195.7 5257.0 5129.3 5140.6 5228.2 5312.4 5357.4 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#4] prototype.html Cycles:180 Average:4875.67 Median:5481.12 stddev:1466.97 (26.8%) stddev-sans-first:1430.48 11:59:11 INFO - PROCESS | 31393 | Values: 308.8 319.5 322.4 322.8 326.0 5520.7 5545.2 5587.4 5694.5 5734.1 5594.4 5618.4 5633.4 5640.8 5699.3 4389.6 4392.7 4393.9 4394.5 4416.4 4157.2 4355.2 4358.5 4441.0 4442.2 4304.7 4310.9 4349.4 4352.3 4366.4 4340.3 4354.6 4361.3 4379.4 4384.1 3736.9 3753.2 3826.2 3838.7 3841.0 5366.8 5394.4 5409.6 5419.8 5427.2 4913.5 4914.4 4947.8 4949.6 4972.3 5738.6 5816.2 5859.2 5865.2 5893.6 4093.9 4100.2 4105.4 4108.2 4133.9 6093.8 6096.4 6109.6 6122.8 6152.7 4044.8 4180.3 4198.4 4204.8 4219.2 4246.3 4249.8 4270.3 4294.3 4299.4 4911.4 4920.8 4943.8 4951.7 4965.5 5835.9 5886.6 5914.9 5958.8 5964.2 1475.6 1481.4 1490.5 1495.5 1501.3 872.9 906.0 917.4 927.8 928.0 5019.2 5039.5 5046.0 5112.3 5143.2 5379.7 5435.5 5438.7 5451.2 5496.6 4769.9 4894.0 5062.7 5125.0 5147.4 2868.9 2872.4 2879.8 2935.5 2942.8 5477.5 5484.7 5519.6 5527.2 5528.3 5440.2 5717.9 6224.3 6243.4 6250.7 6302.6 6307.6 6313.7 6321.6 6340.5 5989.4 6068.9 6145.6 6155.7 6159.8 6050.6 6058.5 6062.2 6064.2 6072.3 5713.4 6376.4 6379.6 6409.0 6431.5 4205.8 4239.1 4262.7 4290.7 4294.7 6077.4 6124.8 6152.6 6218.2 6239.9 5669.7 5922.1 5936.0 5999.9 6015.9 5868.1 5881.3 5945.0 5955.6 5955.8 5836.5 5845.6 5855.2 5870.6 5872.2 5674.6 5992.2 5999.0 6003.8 6007.6 5887.1 5929.6 5931.4 5942.9 5949.6 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - PROCESS | 31393 | [#5] yui.html Cycles:180 Average:20168.05 Median:4211.49 stddev:28599.03 (679.1%) stddev-sans-first:28642.12 11:59:11 INFO - PROCESS | 31393 | Values: 758.4 765.9 781.1 799.3 801.9 15520.4 16182.5 16421.8 16500.3 16525.5 14957.6 15006.2 15027.1 15029.1 15068.3 673.2 786.2 796.4 803.0 804.7 774.9 775.2 782.5 784.1 785.0 829.7 834.8 837.7 838.0 840.7 833.5 833.6 835.5 835.7 838.2 597.9 601.3 601.8 601.8 604.4 15119.2 15129.8 15210.5 15219.5 15219.5 14295.3 15198.0 15246.8 15354.0 15357.2 11543.7 11623.7 11636.5 11765.3 12206.6 3701.5 3860.0 3972.6 4055.8 4067.6 79467.6 80172.2 80433.6 80805.6 82499.6 10300.5 10305.6 10893.9 11112.2 11145.4 16992.5 17049.9 17183.5 17222.5 17229.8 7732.2 7801.7 7936.4 7959.9 8037.6 4536.9 4571.3 4643.2 4684.4 4756.7 3435.8 3524.7 3526.5 3533.5 3537.7 626.1 635.6 638.2 643.9 705.1 660.2 704.3 748.1 755.0 763.6 10375.2 10497.8 10527.9 10549.2 10783.5 707.8 725.8 746.6 749.9 769.4 4355.4 4433.6 4506.6 4522.6 4739.1 98302.5 100924.0 102433.0 112410.4 117511.4 64959.4 73190.6 95718.5 101105.5 101280.5 87830.6 89036.0 89791.0 91322.5 91382.1 9381.6 9502.6 9507.1 9665.2 9677.4 49257.0 49932.8 50710.7 51205.5 52368.2 45350.5 45383.8 75217.4 78954.6 79193.2 13157.0 13195.7 13251.9 13570.7 13874.8 14422.6 14890.6 15053.2 15359.6 15470.6 14262.2 14267.9 14507.0 14522.2 14783.7 13897.7 14074.2 14074.9 14158.0 14376.3 13274.7 13842.8 13907.1 13982.3 14087.4 11225.6 11255.5 11380.9 11571.6 11584.2 11491.7 11540.6 11577.8 11821.2 12067.8 11:59:11 INFO - PROCESS | 31393 | -------- Summary: end -------- 11:59:11 INFO - PROCESS | 31393 | 11:59:11 INFO - TEST-INFO | 31393: exit 0 11:59:11 INFO - TEST-OK | dromaeo_css | took 1110678ms 11:59:11 INFO - TEST-START | kraken 11:59:11 INFO - operating with platform_type : linux_ 11:59:11 INFO - Initialising browser for kraken test... 11:59:11 INFO - TEST-INFO | started process 31622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4fjOB/profile http://localhost:38950/getInfo.html) 11:59:16 INFO - PROCESS | 31622 | __metrics Screen width/height:1600/1200 11:59:16 INFO - PROCESS | 31622 | colorDepth:24 11:59:16 INFO - PROCESS | 31622 | Browser inner width/height: 1024/697 11:59:16 INFO - PROCESS | 31622 | __metrics 11:59:17 ERROR - PROCESS | 31622 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 11:59:18 INFO - TEST-INFO | 31622: exit 0 11:59:18 INFO - Browser initialized. 11:59:18 INFO - Running cycle 1/1 for kraken test... 11:59:18 INFO - TEST-INFO | started process 31743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx4fjOB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:30 INFO - PROCESS | 31743 | RSS: Main: 167743488 11:59:30 INFO - PROCESS | 31743 | 11:59:32 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38950/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:33 INFO - PROCESS | 31743 | RSS: Main: 172560384 11:59:33 INFO - PROCESS | 31743 | 11:59:36 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38950/tests/kraken/driver.html?testName=audio-dft) 11:59:36 INFO - PROCESS | 31743 | RSS: Main: 172425216 11:59:36 INFO - PROCESS | 31743 | 11:59:39 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38950/tests/kraken/driver.html?testName=audio-fft) 11:59:40 INFO - PROCESS | 31743 | RSS: Main: 166981632 11:59:40 INFO - PROCESS | 31743 | 11:59:42 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38950/tests/kraken/driver.html?testName=audio-oscillator) 11:59:43 INFO - PROCESS | 31743 | RSS: Main: 167874560 11:59:43 INFO - PROCESS | 31743 | 11:59:45 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:46 INFO - PROCESS | 31743 | RSS: Main: 167919616 11:59:46 INFO - PROCESS | 31743 | 11:59:49 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38950/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:49 INFO - PROCESS | 31743 | RSS: Main: 168706048 11:59:49 INFO - PROCESS | 31743 | 11:59:53 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38950/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:53 INFO - PROCESS | 31743 | RSS: Main: 168529920 11:59:53 INFO - PROCESS | 31743 | 11:59:56 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38950/tests/kraken/driver.html?testName=json-parse-financial) 11:59:57 INFO - PROCESS | 31743 | RSS: Main: 168517632 11:59:57 INFO - PROCESS | 31743 | 11:59:58 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:59 INFO - PROCESS | 31743 | RSS: Main: 168718336 11:59:59 INFO - PROCESS | 31743 | 12:00:01 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:01 INFO - PROCESS | 31743 | RSS: Main: 169242624 12:00:01 INFO - PROCESS | 31743 | 12:00:03 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:04 INFO - PROCESS | 31743 | RSS: Main: 169246720 12:00:04 INFO - PROCESS | 31743 | 12:00:07 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:07 INFO - PROCESS | 31743 | RSS: Main: 169590784 12:00:07 INFO - PROCESS | 31743 | 12:00:10 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:11 INFO - PROCESS | 31743 | RSS: Main: 169349120 12:00:11 INFO - PROCESS | 31743 | 12:00:12 INFO - PROCESS | 31743 | Cycle 1(1): loaded http://localhost:38950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38950/tests/kraken/driver.html?testName=ai-astar) 12:00:13 INFO - PROCESS | 31743 | RSS: Main: 170229760 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | __start_tp_report 12:00:13 INFO - PROCESS | 31743 | _x_x_mozilla_page_load 12:00:13 INFO - PROCESS | 31743 | _x_x_mozilla_page_load_details 12:00:13 INFO - PROCESS | 31743 | |i|pagename|runs| 12:00:13 INFO - PROCESS | 31743 | |0;ai-astar;112;107;111;111;112;112;111;110;111;112 12:00:13 INFO - PROCESS | 31743 | |1;audio-beat-detection;156;127;153;187;131;162;156;126;203;135 12:00:13 INFO - PROCESS | 31743 | |2;audio-dft;164;163;161;162;166;177;163;163;163;162 12:00:13 INFO - PROCESS | 31743 | |3;audio-fft;75;75;74;160;76;75;76;77;161;76 12:00:13 INFO - PROCESS | 31743 | |4;audio-oscillator;86;85;147;84;86;84;139;85;85;146 12:00:13 INFO - PROCESS | 31743 | |5;imaging-gaussian-blur;117;119;118;117;118;117;118;117;117;119 12:00:13 INFO - PROCESS | 31743 | |6;imaging-darkroom;147;148;147;149;148;149;147;147;146;148 12:00:13 INFO - PROCESS | 31743 | |7;imaging-desaturate;97;97;96;96;96;96;99;96;96;96 12:00:13 INFO - PROCESS | 31743 | |8;json-parse-financial;54;53;54;54;54;53;53;53;55;54 12:00:13 INFO - PROCESS | 31743 | |9;json-stringify-tinderbox;61;62;67;62;61;62;61;62;62;62 12:00:13 INFO - PROCESS | 31743 | |10;stanford-crypto-aes;80;85;86;80;81;87;80;81;105;81 12:00:13 INFO - PROCESS | 31743 | |11;stanford-crypto-ccm;138;128;130;129;129;123;134;130;139;133 12:00:13 INFO - PROCESS | 31743 | |12;stanford-crypto-pbkdf2;160;160;161;162;158;171;160;163;159;158 12:00:13 INFO - PROCESS | 31743 | |13;stanford-crypto-sha256-iterative;67;66;64;63;67;63;62;64;62;62 12:00:13 INFO - PROCESS | 31743 | __end_tp_report 12:00:13 INFO - PROCESS | 31743 | __start_cc_report 12:00:13 INFO - PROCESS | 31743 | _x_x_mozilla_cycle_collect,877 12:00:13 INFO - PROCESS | 31743 | __end_cc_report 12:00:13 INFO - PROCESS | 31743 | __startTimestamp1465239613125__endTimestamp 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | ------- Summary: start ------- 12:00:13 INFO - PROCESS | 31743 | Number of tests: 14 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.52 (1.4%) stddev-sans-first:1.56 12:00:13 INFO - PROCESS | 31743 | Values: 112.0 107.0 111.0 111.0 112.0 112.0 111.0 110.0 111.0 112.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:156.00 stddev:25.74 (16.5%) stddev-sans-first:27.29 12:00:13 INFO - PROCESS | 31743 | Values: 156.0 127.0 153.0 187.0 131.0 162.0 156.0 126.0 203.0 135.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.62 (2.8%) stddev-sans-first:4.90 12:00:13 INFO - PROCESS | 31743 | Values: 164.0 163.0 161.0 162.0 166.0 177.0 163.0 163.0 163.0 162.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:35.85 (47.5%) stddev-sans-first:37.46 12:00:13 INFO - PROCESS | 31743 | Values: 75.0 75.0 74.0 160.0 76.0 75.0 76.0 77.0 161.0 76.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.58 (33.6%) stddev-sans-first:29.67 12:00:13 INFO - PROCESS | 31743 | Values: 86.0 85.0 147.0 84.0 86.0 84.0 139.0 85.0 85.0 146.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 12:00:13 INFO - PROCESS | 31743 | Values: 117.0 119.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 119.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.00 12:00:13 INFO - PROCESS | 31743 | Values: 147.0 148.0 147.0 149.0 148.0 149.0 147.0 147.0 146.0 148.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 12:00:13 INFO - PROCESS | 31743 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 99.0 96.0 96.0 96.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 12:00:13 INFO - PROCESS | 31743 | Values: 54.0 53.0 54.0 54.0 54.0 53.0 53.0 53.0 55.0 54.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.75 (2.8%) stddev-sans-first:1.80 12:00:13 INFO - PROCESS | 31743 | Values: 61.0 62.0 67.0 62.0 61.0 62.0 61.0 62.0 62.0 62.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.00 stddev:7.65 (9.4%) stddev-sans-first:7.93 12:00:13 INFO - PROCESS | 31743 | Values: 80.0 85.0 86.0 80.0 81.0 87.0 80.0 81.0 105.0 81.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:131.50 stddev:4.81 (3.7%) stddev-sans-first:4.45 12:00:13 INFO - PROCESS | 31743 | Values: 138.0 128.0 130.0 129.0 129.0 123.0 134.0 130.0 139.0 133.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.20 Median:160.50 stddev:3.79 (2.4%) stddev-sans-first:4.00 12:00:13 INFO - PROCESS | 31743 | Values: 160.0 160.0 161.0 162.0 158.0 171.0 160.0 163.0 159.0 158.0 12:00:13 INFO - PROCESS | 31743 | 12:00:13 INFO - PROCESS | 31743 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:2.00 (3.1%) stddev-sans-first:1.80 12:00:13 INFO - PROCESS | 31743 | Values: 67.0 66.0 64.0 63.0 67.0 63.0 62.0 64.0 62.0 62.0 12:00:13 INFO - PROCESS | 31743 | -------- Summary: end -------- 12:00:13 INFO - PROCESS | 31743 | 12:00:14 INFO - TEST-INFO | 31743: exit 0 12:00:14 INFO - TEST-OK | kraken | took 62254ms 12:00:14 INFO - SUITE-END | took 1172s 12:00:14 INFO - Completed test suite (00:19:33) 12:00:14 INFO - javascript benchmark 12:00:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7291.882378188269, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.421242070217, 3149.3543823516184, 3160.383725173589, 3177.8252196129206, 3199.9680003199974, 5418.485243901828, 5467.835964921053, 5495.038368285549, 5580.748866301016, 5607.551395888329, 5380.381256155543, 5474.288342515468, 5475.425080366564, 5482.80810171644, 5537.197106419577, 4950.826721064773, 4987.426445958725, 5077.959018401238, 5107.38711354638, 5162.5095615916425, 582.7271320229063, 4905.533974272438, 4987.551120399164, 5031.993601279741, 5059.392872855263, 5009.298698182258, 5015.52352526513, 5043.974780126095, 5059.443461219263, 5063.215201643733, 5046.26829109777, 5046.899062018739, 5050.873728156789, 5065.670731402484, 5080.415752188509, 4918.606511479073, 4929.65492415531, 5003.324551185616, 5023.974880125576, 5048.040872234264, 5434.429384914567, 5453.836384908459, 5499.395066542677, 5533.501984821345, 5579.442055794429, 5725.341585717654, 5797.594168408213, 5918.8816223675285, 5970.194023806774, 5992.490638295706, 5921.378255283219, 5974.761009559613, 5977.163197152402, 5992.9700351498395, 6068.726907289182, 5564.360098588633, 5566.693831839248, 5571.052921003439, 5571.331440227199, 5582.302212223472, 5921.73352199152, 6063.333033366326, 6086.786962456293, 6116.418940200674, 6117.969410153009, 5918.171455996164, 5918.852028699317, 5929.0, 5930.140129681172, 5962.016267315931, 6002.909956350658, 6006.759729610767, 6015.909761353583, 6018.668973206516, 6034.0, 5670.092785154356, 5846.4153584642045, 5895.882082358329, 5911.113333000085, 5982.611130276518, 5826.592138550261, 5903.35063143054, 5913.2608423947, 5931.9406805931385, 5965.821025369246, 4467.30756732707, 4478.171538265431, 4483.349914262479, 4497.482789479186, 4498.775061246924, 3887.8833634990997, 3895.454636350913, 3960.683145348365, 3998.2203470323007, 4022.135240923157, 5649.519790817744, 5653.943460565341, 5656.434356564393, 5683.715814209356, 5693.202951586781, 5995.070764031582, 6014.36849130835, 6048.727807248684, 6074.665893375906, 6076.665783381868, 5519.530839878575, 5628.831135065954, 5632.633878797865, 5686.545076393879, 5687.175359572839, 5086.898262034739, 5119.59043276537, 5128.230765385222, 5131.332926719577, 5148.0476111919415, 5995.820125396158, 6156.322804491502, 6181.938180618136, 6182.876342473215, 6203.379662033761, 5916.230889984275, 5950.85122871923, 5957.106434034929, 5982.551308651781, 5988.251468566429, 6154.784582539769, 6155.692215389123, 6162.722677479434, 6162.784302549389, 6189.535784816067, 5711.086226203787, 5714.571407144564, 5862.706864656665, 5866.178734977021, 5898.7935422261735, 6021.849453763691, 6072.362401947732, 6074.483668888194, 6088.208532890696, 6107.5724699272405, 5858.531317494675, 5910.0, 5922.5261979040715, 5932.377100404568, 5959.731812068554, 5640.956423061747, 5786.479216870502, 5922.170896074467, 5935.910961335497, 5940.554458415722, 5699.971500142638, 5724.856878578069, 5749.396313387034, 5776.451237132634, 5809.360970293349, 5855.473007429352, 5856.765729370777, 5861.648301101947, 5880.14737863016, 5896.14505896634, 5514.6691198528215, 5708.743106560298, 5746.9712651436475, 5769.1634712967225, 5775.249217601685], "value": 5440.852588032213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.600553606939, 610.2311088029084, 611.9632822030676, 627.5920651576477, 645.7062036773268, 40715.59284407155, 42245.57754422455, 42463.78768106163, 42704.35943460851, 42742.358864617054, 43410.0, 44095.77952110243, 44124.338134928, 44191.33712994308, 44288.0, 8671.30629549636, 8813.515256660881, 8858.73423797287, 8873.245774109177, 8888.555572221396, 8689.131086891324, 8716.477011379338, 8763.342749293828, 8768.210861022506, 8775.254103401187, 8768.298536117096, 8783.253423458982, 8822.867656985118, 8830.823383532326, 8831.337649676268, 8706.695265665734, 8721.60752766127, 8743.213110820025, 8803.119688031178, 8823.07357727439, 8507.489550626982, 8655.870161947576, 8661.783455413602, 8664.696735614287, 8682.0, 40349.0, 40664.593354066375, 40674.59325406767, 40703.18593628141, 40892.79553602243, 3519.278547897675, 3593.6406359364114, 3595.209054008114, 3617.620149884277, 4054.452648892391, 32002.359952801045, 32280.838595806872, 32478.0, 33073.173170670685, 33892.152696182544, 4283.550227226158, 4353.912921741579, 4374.518802931675, 4375.16871794358, 4394.582514661102, 256860.0, 257210.99999999814, 257610.0, 257846.0, 258785.0, 34687.479687804705, 57818.0, 59504.70247648821, 59505.70247148736, 59571.0, 34684.0, 37259.0, 37384.81307593499, 37412.0, 37450.62549374526, 15395.3072111753, 15484.148371839432, 15669.138197399025, 15671.451499197474, 15684.92157539205, 12953.740925181444, 12960.157589756636, 12973.221606703628, 12996.48014079445, 13001.349932503337, 8336.249737523653, 8348.874766878502, 8354.122817104238, 8443.577821109044, 8445.366597505212, 3229.935401291961, 3278.508223766454, 3291.8518666660057, 3293.094399040235, 3329.167708072982, 1029.1766586730585, 1053.1732589916878, 1056.2078441169124, 1064.2443864856039, 1173.7887180307455, 32564.34871302608, 32782.67217327796, 32861.3427731444, 32939.83530082382, 33355.666443335256, 1120.42858142348, 1131.3833960491552, 1145.204083162211, 1229.4037391864938, 1243.210561293585, 16797.916010420115, 17020.744688829676, 17107.74338384925, 17213.0, 17566.736498952527, 567855.5715542746, 569228.0, 571734.0, 573340.0, 574272.0, 59366.406335936954, 59915.70042149761, 60412.09381859276, 60452.69773651192, 60532.394676053555, 1357.9524716635067, 1423.323921137472, 1427.664498842771, 1434.4538444261311, 1439.172475826404, 31087.378252435275, 31855.840720797176, 32046.83976580102, 32424.35151297008, 32445.51331729979, 50421.74789126031, 50517.242241367145, 50970.74514627403, 51178.97642047213, 51286.48713512966, 443929.0, 458463.0, 458641.0, 459640.0, 462676.0, 27137.1858844235, 27416.314592135357, 27730.0, 27938.72061279361, 28040.57939130874, 48208.758956205, 48301.27548086852, 48557.0, 49713.0, 49758.50241497539, 40015.39976900407, 40910.0, 41473.585264148176, 42167.789161055225, 42784.786076069424, 41538.37692434555, 41886.79056604698, 42036.159276814906, 42404.36393454162, 42805.78597106995, 41327.0, 41613.0, 42360.364594531726, 42492.0, 44676.77661611671, 33537.832310839265, 36619.0, 37931.810340949225, 40390.0, 40658.79670601628, 28787.568186477638, 28829.279268017628, 28992.42015159727, 29027.854860726406, 29039.0], "value": 18963.91358582212, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9068537269976, 387.60851539944656, 387.9806009699514, 389.5597974289053, 409.1653027823241, 18110.456686299414, 19531.218751249933, 19583.314583989526, 19744.0, 19834.30579929701, 18651.1606977686, 18772.0, 19001.904990475065, 19229.038548072574, 19508.122134503945, 5523.475269849358, 5591.1054231323, 5629.887402251952, 5639.436056394348, 5710.314762228539, 5518.117101263799, 5527.723613819313, 5634.647684555697, 5657.434256574351, 5664.886702265972, 5439.428859969706, 5618.381977982419, 5667.546596272309, 5677.943220567783, 5770.134479828039, 5764.308283006024, 5784.363719990798, 5798.275215598051, 5803.82588522345, 5814.563907706918, 5500.064988951888, 5630.408807075239, 5668.291463567054, 5687.203791469197, 5699.2306038684665, 13936.651583710387, 13966.231857247847, 14009.71980560383, 20237.291694790612, 22771.31686049421, 2234.9888250558806, 2347.7886990170796, 2486.987565062163, 2647.2455350225287, 2904.19146813084, 9655.855162172573, 10268.229882758824, 10463.581456741722, 10513.737156571071, 10827.350358978487, 1849.704047352417, 1854.9721754173697, 1906.752122224116, 1916.5400303926958, 1954.4722924810364, 64353.3564664352, 73818.26181738167, 76191.61904190555, 81839.0, 85577.14422855755, 10786.298890572089, 11044.392558409365, 11065.446727663584, 11072.726636436913, 11285.37930413835, 15553.377864885504, 15612.29744661493, 15624.218789060502, 15640.843591564166, 15658.217089145497, 8057.35541156706, 8174.877376839352, 8178.713745018896, 8255.463394879314, 8415.789605259917, 7955.801104972306, 7995.960020199862, 8044.798880028046, 8172.141925097898, 8192.221738934792, 4085.9182816343505, 4247.596478334615, 4466.285394336891, 4589.632829373709, 4835.178019736653, 1899.3637131560806, 1909.8281154696144, 1952.1020330647777, 1964.135780256711, 2019.1923230707835, 879.1077056787366, 999.7000899730052, 1021.6066814276558, 1037.1029059863165, 1039.365986748083, 19643.90178049129, 19686.212551498065, 19940.401787946386, 20019.799802002086, 20024.89987550053, 987.9703608891745, 998.6454808543008, 1003.9146672532917, 1005.1807776661997, 1041.234692501011, 10478.580856765644, 11059.115270778319, 11137.498812553455, 11216.887831121747, 11341.716457088638, 516498.0, 526761.0, 528074.0, 529628.0, 531439.0, 84875.5756221215, 94551.0, 97112.51443742737, 97682.0, 98040.50979745056, 979.1383582447401, 1052.821020426514, 1060.7878424315168, 1060.9045185933303, 1061.4851796878509, 17164.656706866044, 17430.389936352167, 18303.26786928508, 18372.540686482946, 18396.632067358845, 43694.0, 43875.0, 44435.55564444314, 44776.0, 45563.0, 61436.0, 62025.65820392529, 62160.0, 63196.0, 63573.36426635859, 8291.62687679068, 8772.0, 8782.165694259034, 8964.865527017231, 9019.233365164035, 12630.810537841757, 13195.736085278433, 13285.867141328463, 13663.658408539866, 13783.104098233583, 11543.538258469904, 11770.82343764827, 11834.567975287415, 12161.635150945485, 12169.634910952685, 11278.774424511628, 11510.769784604428, 11804.527818887149, 11828.0, 12009.519619215134, 11991.820122697993, 12214.206076604993, 12247.510099595916, 12274.140810143204, 12317.322547259986, 8663.913360866563, 8681.392302538761, 8701.738947831574, 8756.38705290649, 8837.602307896288, 9178.311626627896, 11570.0, 11620.012298954345, 12123.575674851338, 12192.207506512048], "value": 9246.089092464219, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.4207201263519, 1528.1976962094898, 1681.2098313792521, 1819.1540933465935, 1825.8082901295356, 7812.3750099992, 8589.441686290402, 8674.392792504526, 9192.310576706748, 9196.218321442677, 8245.340372770179, 8349.248567628912, 8492.957535212316, 8494.532800695959, 8576.614052367642, 2274.692916456282, 2351.9886448826996, 2355.422921384263, 2357.6581395697613, 2364.0780095762666, 2352.306069709431, 2359.7050368703913, 2387.415083304593, 2390.5577468168444, 2407.6629271901948, 2361.645753137026, 2383.7020372453444, 2400.015993442689, 2413.2157048959157, 2421.9394515137087, 2280.2361208995007, 2289.7824706652923, 2299.275728145637, 2299.735530414007, 2306.1351993002622, 2256.4133325335365, 2263.2757517594378, 2264.6376579747325, 2267.0, 2274.6815445837597, 8806.383553151281, 8886.600102995317, 8903.154200350957, 8908.465492070432, 8941.776455588597, 5195.766190521435, 5221.242919776649, 5347.144456886918, 5353.785848566092, 5394.109971854639, 3446.2418267981, 3519.225770330523, 3592.6227746086547, 3629.1290090378384, 3636.5999740028574, 1166.650004998497, 1191.7199458127334, 1197.8382918306093, 1221.407617305606, 1224.644852992631, 12243.32661703606, 12525.0, 12530.74938501234, 12544.310062946533, 12632.74734505314, 4493.707908985971, 4512.684112112186, 4517.796699148546, 4554.066416384633, 4654.092451971901, 10523.263371563917, 10554.10290125348, 10556.102731267774, 10564.788704225872, 10576.57693692259, 5211.739413029333, 5240.423553409122, 5307.2569840222395, 5315.309009828775, 5317.909828485152, 4259.637930775919, 4804.135255653946, 4882.096812089775, 4961.727105009187, 4969.90060198794, 4143.81352839123, 4145.958540414617, 4215.135897141079, 4215.135897141079, 4216.219999300078, 1267.3283159925254, 1282.538286216961, 1290.2581015915887, 1291.3607764156802, 1294.2687381629348, 876.8114855306139, 967.4243824924159, 985.014985014985, 1070.71626019105, 1074.9677509674723, 6258.499320054385, 6264.780732674426, 6365.3316401778075, 6408.935910640927, 6597.670116494252, 979.3878825733916, 984.5667906121283, 989.7228775942604, 1004.638330201127, 1030.5208078243652, 4173.561776013536, 4218.346156345771, 4240.597143271446, 4282.379055037064, 4300.311950087971, 11125.443727813577, 11366.09071274296, 11408.657740267805, 11421.42892855354, 11473.770524589461, 10879.347239165518, 11325.037371823488, 11381.772364552662, 11409.48657310423, 11431.885681143249, 8497.447665901696, 8566.314694824274, 8589.785255368666, 8622.353323500762, 8642.567871606394, 6132.47873930703, 6333.145025421693, 6370.108184854032, 6514.869702606016, 6534.83662908412, 10487.213458990758, 10649.0, 10719.356838589709, 10781.838272426077, 10784.406857622906, 10536.473176341306, 10681.51933162994, 10860.511276992396, 10937.781244374908, 11001.889981100087, 7236.963815181101, 7946.245106714853, 8079.474834135997, 8136.593170341341, 8179.83640327202, 8929.910700893168, 8935.106489351012, 9018.188363047357, 9059.048799876182, 9083.909160908306, 7772.961135194514, 7931.167227441036, 7954.211478014871, 7999.920000799918, 8038.0, 7981.680732770624, 8022.558759268063, 8039.15588863161, 8226.506409615442, 8241.217084376975, 7253.637318133967, 7374.483786134919, 7378.335949764332, 7477.327040566375, 7482.326590606872, 5122.436531981404, 5151.871203219949, 5191.636585438983, 5195.68825870449, 5257.0, 5129.256257842518, 5140.6096165283325, 5228.215767634885, 5312.442193569619, 5357.437469065692], "value": 4776.555534977792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.77150908327843, 319.4951975878113, 322.4453939224534, 322.8047031545915, 325.9926826107328, 5520.696361700105, 5545.195946587743, 5587.413321601234, 5694.459026392491, 5734.111212762024, 5594.412586678402, 5618.353889302732, 5633.380328163898, 5640.774369025245, 5699.287589051369, 4389.62688171505, 4392.714473559208, 4393.912121757563, 4394.516603173664, 4416.425864637593, 4157.210130075291, 4355.237833379162, 4358.542353052915, 4440.978574927769, 4442.178197033559, 4304.677149213806, 4310.892227694301, 4349.369341445488, 4352.3471479278205, 4366.388705581221, 4340.262155433584, 4354.628292087982, 4361.34579813029, 4379.364992076163, 4384.05742765307, 3736.9439458408146, 3753.1555400035045, 3826.1582451860545, 3838.6929045676557, 3841.020539762371, 5366.758495867695, 5394.352677678665, 5409.648372855751, 5419.756110975016, 5427.213054107172, 4913.508649135094, 4914.434839993375, 4947.777350019258, 4949.554540091373, 4972.254161875711, 5738.626989245686, 5816.1566572846705, 5859.209006784072, 5865.237519122529, 5893.58744887858, 4093.89765255868, 4100.2414553307735, 4105.4252404663375, 4108.198901214264, 4133.8966525836795, 6093.756249750005, 6096.359882212349, 6109.5723299369065, 6122.785702500391, 6152.692365381758, 4044.8179831907046, 4180.289350810309, 4198.3702444633545, 4204.810783514749, 4219.156168766259, 4246.320588705854, 4249.830006799755, 4270.274053410928, 4294.26997410441, 4299.419578356944, 4911.386076740408, 4920.778564964585, 4943.826966056243, 4951.702897826142, 4965.528274813887, 5835.883282334329, 5886.6173698709445, 5914.852128696731, 5958.76164953397, 5964.194833697482, 1475.638468575206, 1481.4370539195038, 1490.508132316333, 1495.48405800001, 1501.2718831366778, 872.882160908282, 906.0441234497537, 917.4495302818256, 927.7707038174445, 927.9536023198813, 5019.171836646912, 5039.496050394931, 5045.974770126126, 5112.335396398519, 5143.151380022329, 5379.73101344939, 5435.483629055233, 5438.700871452108, 5451.236826844245, 5496.615236933376, 4769.928451073237, 4893.996730670204, 5062.7468626568525, 5124.9500199919585, 5147.433782283946, 2868.8709008094684, 2872.3824377758883, 2879.7696184305205, 2935.515639919432, 2942.764578833688, 5477.534409575231, 5484.698341591251, 5519.558435325164, 5527.226188333637, 5528.273326305951, 5440.238366628596, 5717.857053573611, 6224.315325314212, 6243.410039227462, 6250.656213908279, 6302.558820882494, 6307.5584709070845, 6313.652749098752, 6321.55749097568, 6340.461060809883, 5989.371116032754, 6068.8786224276155, 6145.631262124287, 6155.72299246526, 6159.753609855556, 6050.606710563799, 6058.454739073504, 6062.242219722535, 6064.241969753781, 6072.271327440559, 5713.371529131709, 6376.39424254695, 6379.585326953918, 6408.955746020603, 6431.488600179047, 4205.831766729297, 4239.0674051708575, 4262.680298977527, 4290.742555446684, 4294.742315461082, 6077.4226448487325, 6124.755009799558, 6152.569320147547, 6218.19163508741, 6239.875202495834, 5669.659820410789, 5922.141289512911, 5935.970320148372, 5999.880002400015, 6015.879682406415, 5868.122200895672, 5881.2942446906645, 5944.970275148769, 5955.553333499918, 5955.76176952917, 5836.548649567107, 5845.620034697731, 5855.214159681338, 5870.618409803349, 5872.207252020922, 5674.631148975303, 5992.194956202756, 5998.970005149947, 6003.81988540327, 6007.639541627516, 5887.146363777314, 5929.584929055098, 5931.436513531207, 5942.851428714317, 5949.553783466344], "value": 4395.362317247484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.3705524414736, 765.8889461028149, 781.1251398433751, 799.3365506629498, 801.8676918308475, 15520.379184832607, 16182.514524564252, 16421.753673694875, 16500.25748841302, 16525.504234872944, 14957.551273461786, 15006.249687515636, 15027.121609798774, 15029.098254104762, 15068.32192551335, 673.1921693967234, 786.1705900275207, 796.3509739562253, 802.9839403211932, 804.6660635836121, 774.8527779721863, 775.244136966456, 782.4913806026071, 784.1100351101512, 784.9725259615915, 829.6971605364029, 834.7620928035511, 837.6774941647479, 837.9664813407487, 840.7267638017669, 833.4707460762398, 833.6373677450268, 835.5195762436593, 835.6949713354612, 838.1576515601812, 597.9013462778636, 601.287474342905, 601.8104297146385, 601.8344955137328, 604.3956043956044, 15119.16844573548, 15129.848701512954, 15210.543683689508, 15219.467318643794, 15219.543413697496, 14295.285235738276, 15198.0, 15246.771298430533, 15354.0, 15357.232138393036, 11543.711407214887, 11623.709407264885, 11636.476358563885, 11765.294082355085, 12206.633800985985, 3701.481792549045, 3859.9807000964815, 3972.6226008529143, 4055.7566546007333, 4067.5729048449784, 79467.6026619869, 80172.19827801705, 80433.59783201104, 80805.59597202035, 82499.5875020627, 10300.484975751182, 10305.639302624371, 10893.891061089445, 11112.222144449972, 11145.442727863574, 16992.490225293262, 17049.91475042642, 17183.484495465156, 17222.483325500256, 17229.827701723072, 7732.226777322223, 7801.6879324827505, 7936.365090792723, 7959.880601790977, 8037.557934313552, 4536.9092618148115, 4571.291449825282, 4643.187442197602, 4684.4378674559275, 4756.714597124114, 3435.793852368866, 3524.7356448266482, 3526.4710293456187, 3533.5406397168717, 3537.663921927413, 626.0827887145354, 635.5678138865616, 638.1894993358502, 643.8744444833212, 705.104517263073, 660.1747815230962, 704.3414407528977, 748.098541257783, 754.9962250188714, 763.5952944939191, 10375.16998640107, 10497.790044199073, 10527.94736026315, 10549.156067514581, 10783.46082695862, 707.8018154916632, 725.7677543186236, 746.5931067568189, 749.8912657664608, 769.3768047881234, 4355.412019377407, 4433.645308375322, 4506.59440650343, 4522.570355816258, 4739.075880203396, 98302.50848745853, 100924.0, 102433.0, 112410.43794780974, 117511.41244293723, 64959.350406496276, 73190.63404682942, 95718.52140739252, 101105.49447252716, 101280.49359753302, 87830.56084719663, 89036.0, 89791.0, 91322.54338728264, 91382.08617913869, 9381.624735010522, 9502.572384242587, 9507.096825801538, 9665.226781857575, 9677.419354838732, 49257.0, 49932.750336248086, 50710.746446267534, 51205.48794512007, 52368.16711415082, 45350.54649453463, 45383.773081134386, 75217.36739214101, 78954.6052269735, 79193.20806792089, 13157.0, 13195.670108246986, 13251.867481325064, 13570.660733481742, 13874.791878122038, 14422.639434014234, 14890.627734306729, 15053.247337633293, 15359.61600959985, 15470.613234669223, 14262.215578143301, 14267.857321426653, 14507.0, 14522.20127892976, 14783.704325913206, 13897.722045559234, 14074.225917574222, 14074.859251407355, 14158.0, 14376.348683883198, 13274.734505309647, 13842.792358114435, 13907.096038757449, 13982.300884955916, 14087.366068526735, 11225.550977960791, 11255.493502792559, 11380.886191138314, 11571.56598404145, 11584.189106762446, 11491.655250342503, 11540.596079137189, 11577.768444631229, 11821.23161994502, 12067.81898271509], "value": 7504.737144076851, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 153.0, 187.0, 131.0, 162.0, 156.0, 126.0, 203.0, 135.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 162.0, 166.0, 177.0, 163.0, 163.0, 163.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 160.0, 76.0, 75.0, 76.0, 77.0, 161.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 147.0, 84.0, 86.0, 84.0, 139.0, 85.0, 85.0, 146.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 148.0, 149.0, 147.0, 147.0, 146.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 99.0, 96.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0, 53.0, 55.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 67.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 86.0, 80.0, 81.0, 87.0, 80.0, 81.0, 105.0, 81.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 128.0, 130.0, 129.0, 129.0, 123.0, 134.0, 130.0, 139.0, 133.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 158.0, 171.0, 160.0, 163.0, 159.0, 158.0], "value": 161.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 63.0, 67.0, 63.0, 62.0, 64.0, 62.0, 62.0], "value": 64.0, "unit": "score"}]}]} 12:00:14 INFO - Return code: 0 12:00:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:14 ERROR - # TBPL SUCCESS # 12:00:14 INFO - Running post-action listener: _resource_record_post_action 12:00:14 INFO - ##### 12:00:14 INFO - ##### Finished run-tests step (success) 12:00:14 INFO - ##### 12:00:14 INFO - Running post-run listener: _resource_record_post_run 12:00:14 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 301748224; Read time: 12; Write time: 201608 12:00:14 INFO - TinderboxPrint: CPU usage
13.5% 12:00:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:00:14 INFO - TinderboxPrint: I/O write bytes / time
301,748,224 / 201,608 12:00:14 INFO - TinderboxPrint: CPU idle
8,220.0 (86.5%) 12:00:14 INFO - TinderboxPrint: CPU user
1,227.7 (12.9%) 12:00:14 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14041088; Read time: 0; Write time: 2360 12:00:14 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 4096; Write bytes: 286941184; Read time: 12; Write time: 199140 12:00:15 INFO - Running post-run listener: _upload_blobber_files 12:00:15 INFO - Blob upload gear active. 12:00:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:15 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:00:15 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:00:15 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:00:15 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:16 INFO - (blobuploader) - INFO - Done attempting. 12:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:21 INFO - (blobuploader) - INFO - Done attempting. 12:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:21 INFO - (blobuploader) - INFO - Done attempting. 12:00:21 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:21 INFO - Return code: 0 12:00:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6534df14924be8c73103cf082e1953611ac6909efb7c65270735ece5ef2a95ab3e2e802185922c3b024cbb1085adbe8f4bdd6ab9aab1669b61a726d61adf2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a1c0e50513e3030d6ec5ba7678b5a966fc813a2d5a4eff1282d53a923d1c952c9308c52d2866044a6c2caa29ee43bb3a71494316eb481d733702e4dbaa65cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01b12315746f890f19e9d74e2e19bd9f4b942a39d9877170998dac154b141615d349dafb07b0c537c95f39780aa0ab025eb40c4717209fd084dfa79a55c13c01"} 12:00:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:21 INFO - Contents: 12:00:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6534df14924be8c73103cf082e1953611ac6909efb7c65270735ece5ef2a95ab3e2e802185922c3b024cbb1085adbe8f4bdd6ab9aab1669b61a726d61adf2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a1c0e50513e3030d6ec5ba7678b5a966fc813a2d5a4eff1282d53a923d1c952c9308c52d2866044a6c2caa29ee43bb3a71494316eb481d733702e4dbaa65cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01b12315746f890f19e9d74e2e19bd9f4b942a39d9877170998dac154b141615d349dafb07b0c537c95f39780aa0ab025eb40c4717209fd084dfa79a55c13c01"} 12:00:21 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:21 INFO - Copying logs to upload dir... 12:00:21 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1638.146988 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 18 secs) (at 2016-06-06 12:00:21.653222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:00:21.656987) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 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/6534df14924be8c73103cf082e1953611ac6909efb7c65270735ece5ef2a95ab3e2e802185922c3b024cbb1085adbe8f4bdd6ab9aab1669b61a726d61adf2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a1c0e50513e3030d6ec5ba7678b5a966fc813a2d5a4eff1282d53a923d1c952c9308c52d2866044a6c2caa29ee43bb3a71494316eb481d733702e4dbaa65cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01b12315746f890f19e9d74e2e19bd9f4b942a39d9877170998dac154b141615d349dafb07b0c537c95f39780aa0ab025eb40c4717209fd084dfa79a55c13c01"} 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.011249 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/6534df14924be8c73103cf082e1953611ac6909efb7c65270735ece5ef2a95ab3e2e802185922c3b024cbb1085adbe8f4bdd6ab9aab1669b61a726d61adf2185", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a1c0e50513e3030d6ec5ba7678b5a966fc813a2d5a4eff1282d53a923d1c952c9308c52d2866044a6c2caa29ee43bb3a71494316eb481d733702e4dbaa65cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/01b12315746f890f19e9d74e2e19bd9f4b942a39d9877170998dac154b141615d349dafb07b0c537c95f39780aa0ab025eb40c4717209fd084dfa79a55c13c01"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 12:00:21.682137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:00:21.682468) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465237981.365061-906863257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 12:00:21.764834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:00:21.765159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 12:00:21.765594) ========= ========= Total master_lag: 0.16 =========