builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1470089834.43 results: success (0) buildid: 20160801123750 builduid: 5a38664472d84844bb6ee371e0c4ddcd revision: 3998308ce6053f95dbb3bd814a72eaafb7b31fae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.430194) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.430689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.431131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.446218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.446519) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 15:17:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-08-01 15:17:14 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.601331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.601652) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.650758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:14.651131) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3998308ce6053f95dbb3bd814a72eaafb7b31fae --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3998308ce6053f95dbb3bd814a72eaafb7b31fae --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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 15:17:15,072 truncating revision to first 12 chars 2016-08-01 15:17:15,072 Setting DEBUG logging. 2016-08-01 15:17:15,072 attempt 1/10 2016-08-01 15:17:15,072 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3998308ce605?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 15:17:15,449 unpacking tar archive at: mozilla-beta-3998308ce605/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764397 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:15.429409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:15.429723) ========= script_repo_revision: 3998308ce6053f95dbb3bd814a72eaafb7b31fae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:15.430155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:15.430436) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 15:17:15.440790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-01 15:17:15.441120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:15 INFO - MultiFileLogger online at 20160801 15:17:15 in /builds/slave/test 15:17:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:17:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:15 INFO - {'append_to_log': False, 15:17:15 INFO - 'base_work_dir': '/builds/slave/test', 15:17:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:17:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:15 INFO - 'branch': 'Mozilla-Beta', 15:17:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:15 INFO - 'config_files': ('talos/linux_config.py',), 15:17:15 INFO - 'default_actions': ('clobber', 15:17:15 INFO - 'read-buildbot-config', 15:17:15 INFO - 'download-and-extract', 15:17:15 INFO - 'populate-webroot', 15:17:15 INFO - 'create-virtualenv', 15:17:15 INFO - 'install', 15:17:15 INFO - 'run-tests'), 15:17:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:15 INFO - 'download_minidump_stackwalk': True, 15:17:15 INFO - 'download_symbols': 'ondemand', 15:17:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:15 INFO - 'installer_path': 'installer.exe', 15:17:15 INFO - 'log_level': 'info', 15:17:15 INFO - 'log_name': 'talos', 15:17:15 INFO - 'log_to_console': True, 15:17:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:15 INFO - 'opt_config_files': (), 15:17:15 INFO - 'pip_index': False, 15:17:15 INFO - 'sps_profile': False, 15:17:15 INFO - 'sps_profile_interval': 0, 15:17:15 INFO - 'suite': 'dromaeojs-e10s', 15:17:15 INFO - 'system_bits': '32', 15:17:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:15 INFO - 'title': 'talos-linux64-ix-005', 15:17:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:15 INFO - 'use_talos_json': True, 15:17:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:15 INFO - 'work_dir': 'build'} 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running clobber step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: clobber 15:17:15 INFO - rmtree: /builds/slave/test/build 15:17:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:16 INFO - Running post-action listener: _resource_record_post_action 15:17:16 INFO - ##### 15:17:16 INFO - ##### Finished clobber step (success) 15:17:16 INFO - ##### 15:17:16 INFO - ##### 15:17:16 INFO - ##### Running read-buildbot-config step. 15:17:16 INFO - ##### 15:17:16 INFO - Running pre-action listener: _resource_record_pre_action 15:17:16 INFO - Running main action method: read_buildbot_config 15:17:16 INFO - Using buildbot properties: 15:17:16 INFO - { 15:17:16 INFO - "project": "", 15:17:16 INFO - "product": "firefox", 15:17:16 INFO - "script_repo_revision": "production", 15:17:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:17:16 INFO - "repository": "", 15:17:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:17:16 INFO - "buildid": "20160801123750", 15:17:16 INFO - "pgo_build": "True", 15:17:16 INFO - "basedir": "/builds/slave/test", 15:17:16 INFO - "buildnumber": 63, 15:17:16 INFO - "slavename": "talos-linux64-ix-005", 15:17:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:17:16 INFO - "platform": "ubuntu64_hw", 15:17:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:17:16 INFO - "branch": "mozilla-beta", 15:17:16 INFO - "repo_path": "releases/mozilla-beta", 15:17:16 INFO - "revision": "3998308ce6053f95dbb3bd814a72eaafb7b31fae", 15:17:16 INFO - "stage_platform": "linux64-pgo", 15:17:16 INFO - "builduid": "5a38664472d84844bb6ee371e0c4ddcd", 15:17:16 INFO - "slavebuilddir": "test" 15:17:16 INFO - } 15:17:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 15:17:16 INFO - Running post-action listener: _resource_record_post_action 15:17:16 INFO - ##### 15:17:16 INFO - ##### Finished read-buildbot-config step (success) 15:17:16 INFO - ##### 15:17:16 INFO - ##### 15:17:16 INFO - ##### Running download-and-extract step. 15:17:16 INFO - ##### 15:17:16 INFO - Running pre-action listener: _resource_record_pre_action 15:17:16 INFO - Running main action method: download_and_extract 15:17:16 INFO - mkdir: /builds/slave/test/build/tests 15:17:16 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')]} 15:17:16 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 15:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 15:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 15:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:17:17 INFO - Downloaded 1327 bytes. 15:17:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 15:17:17 INFO - Using the following test package requirements: 15:17:17 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 15:17:17 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:17:17 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 15:17:17 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'jsshell-linux-x86_64.zip'], 15:17:17 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:17:17 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 15:17:17 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 15:17:17 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 15:17:17 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:17:17 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 15:17:17 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:17:17 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:17 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:17:18 INFO - Downloaded 21967605 bytes. 15:17:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:17:20 INFO - Return code: 0 15:17:20 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:17:20 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')]} 15:17:20 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 15:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:17:22 INFO - Downloaded 21967605 bytes. 15:17:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:17:24 INFO - Return code: 0 15:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:24 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:17:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 15:17:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 15:17:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 15:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:17:25 INFO - Downloaded 10833369 bytes. 15:17:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:17:25 INFO - Return code: 0 15:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:25 INFO - https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 15:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 15:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 15:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:17:26 INFO - Downloaded 55283573 bytes. 15:17:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 15:17:26 INFO - mkdir: /builds/slave/test/properties 15:17:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:26 INFO - Contents: 15:17:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 15:17:27 INFO - Running post-action listener: _resource_record_post_action 15:17:27 INFO - Running post-action listener: set_extra_try_arguments 15:17:27 INFO - ##### 15:17:27 INFO - ##### Finished download-and-extract step (success) 15:17:27 INFO - ##### 15:17:27 INFO - ##### 15:17:27 INFO - ##### Running populate-webroot step. 15:17:27 INFO - ##### 15:17:27 INFO - Running pre-action listener: _resource_record_pre_action 15:17:27 INFO - Running main action method: populate_webroot 15:17:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:27 INFO - '--tppagecycles', 15:17:27 INFO - '7'], 15:17:27 INFO - 'tests': ['tsvgm']}}, 15:17:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['damp', 'tps']}, 15:17:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'tests': ['damp', 'tps']}, 15:17:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['dromaeo_dom']}, 15:17:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['a11yr', 15:17:27 INFO - 'ts_paint', 15:17:27 INFO - 'tpaint', 15:17:27 INFO - 'sessionrestore', 15:17:27 INFO - 'sessionrestore_no_auto_restore', 15:17:27 INFO - 'tabpaint']}, 15:17:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['tsvgx', 15:17:27 INFO - 'tsvgr_opacity', 15:17:27 INFO - 'tart', 15:17:27 INFO - 'tscrollx', 15:17:27 INFO - 'cart']}, 15:17:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:27 INFO - 'tsvgr_opacity', 15:17:27 INFO - 'tart', 15:17:27 INFO - 'tscrollx', 15:17:27 INFO - 'cart']}, 15:17:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'talos_options': ['--disable-e10s'], 15:17:27 INFO - 'tests': ['tp5o']}, 15:17:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'tests': ['tp5o']}, 15:17:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'talos_options': ['--disable-e10s', 15:17:27 INFO - '--xperf_path', 15:17:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:27 INFO - 'tests': ['tp5n']}, 15:17:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:27 INFO - 'talos_options': ['--xperf_path', 15:17:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:27 INFO - 'tests': ['tp5n']}}, 15:17:27 INFO - 'talos.zip': {'path': '', 15:17:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:27 INFO - Running post-action listener: _resource_record_post_action 15:17:27 INFO - ##### 15:17:27 INFO - ##### Finished populate-webroot step (success) 15:17:27 INFO - ##### 15:17:27 INFO - ##### 15:17:27 INFO - ##### Running create-virtualenv step. 15:17:27 INFO - ##### 15:17:27 INFO - Running pre-action listener: _resource_record_pre_action 15:17:27 INFO - Running main action method: create_virtualenv 15:17:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:27 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 15:17:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:27 INFO - Using real prefix '/usr' 15:17:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:29 INFO - Installing pip.................done. 15:17:29 INFO - Return code: 0 15:17:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:17:29 INFO - Using env: {'DISPLAY': ':0', 15:17:29 INFO - 'HOME': '/home/cltbld', 15:17:29 INFO - 'LANG': 'en_US.UTF-8', 15:17:29 INFO - 'LANGUAGE': 'en_US:en', 15:17:29 INFO - 'LOGNAME': 'cltbld', 15:17:29 INFO - 'MAIL': '/var/mail/cltbld', 15:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:29 INFO - 'MOZ_NO_REMOTE': '1', 15:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:29 INFO - 'NO_EM_RESTART': '1', 15:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:29 INFO - 'PWD': '/builds/slave/test', 15:17:29 INFO - 'SHELL': '/bin/bash', 15:17:29 INFO - 'SHLVL': '1', 15:17:29 INFO - 'TERM': 'linux', 15:17:29 INFO - 'TMOUT': '86400', 15:17:29 INFO - 'USER': 'cltbld', 15:17:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:29 INFO - '_': '/tools/buildbot/bin/python'} 15:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:30 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 15:17:30 INFO - Cleaning up... 15:17:30 INFO - Return code: 0 15:17:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:30 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:30 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 15:17:30 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 15:17:30 INFO - Using env: {'DISPLAY': ':0', 15:17:30 INFO - 'HOME': '/home/cltbld', 15:17:30 INFO - 'LANG': 'en_US.UTF-8', 15:17:30 INFO - 'LANGUAGE': 'en_US:en', 15:17:30 INFO - 'LOGNAME': 'cltbld', 15:17:30 INFO - 'MAIL': '/var/mail/cltbld', 15:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:30 INFO - 'MOZ_NO_REMOTE': '1', 15:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:30 INFO - 'NO_EM_RESTART': '1', 15:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:30 INFO - 'PWD': '/builds/slave/test', 15:17:30 INFO - 'SHELL': '/bin/bash', 15:17:30 INFO - 'SHLVL': '1', 15:17:30 INFO - 'TERM': 'linux', 15:17:30 INFO - 'TMOUT': '86400', 15:17:30 INFO - 'USER': 'cltbld', 15:17:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:30 INFO - '_': '/tools/buildbot/bin/python'} 15:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:30 INFO - Downloading/unpacking psutil>=3.1.1 15:17:30 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 15:17:30 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 15:17:30 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 15:17:30 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 15:17:30 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 15:17:30 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 15:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:32 INFO - Installing collected packages: psutil 15:17:32 INFO - Running setup.py install for psutil 15:17:32 INFO - building 'psutil._psutil_linux' extension 15:17:32 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 15:17:32 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 15:17:32 INFO - building 'psutil._psutil_posix' extension 15:17:32 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 15:17:32 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 15:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:32 INFO - Successfully installed psutil 15:17:32 INFO - Cleaning up... 15:17:32 INFO - Return code: 0 15:17:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:17:32 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')]} 15:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:32 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')]} 15:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:32 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:32 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 15:17:32 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 15:17:32 INFO - Using env: {'DISPLAY': ':0', 15:17:32 INFO - 'HOME': '/home/cltbld', 15:17:32 INFO - 'LANG': 'en_US.UTF-8', 15:17:32 INFO - 'LANGUAGE': 'en_US:en', 15:17:32 INFO - 'LOGNAME': 'cltbld', 15:17:32 INFO - 'MAIL': '/var/mail/cltbld', 15:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:32 INFO - 'MOZ_NO_REMOTE': '1', 15:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:32 INFO - 'NO_EM_RESTART': '1', 15:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:32 INFO - 'PWD': '/builds/slave/test', 15:17:32 INFO - 'SHELL': '/bin/bash', 15:17:32 INFO - 'SHLVL': '1', 15:17:32 INFO - 'TERM': 'linux', 15:17:32 INFO - 'TMOUT': '86400', 15:17:32 INFO - 'USER': 'cltbld', 15:17:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:32 INFO - '_': '/tools/buildbot/bin/python'} 15:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:17:34 INFO - Installing collected packages: mozsystemmonitor 15:17:34 INFO - Running setup.py install for mozsystemmonitor 15:17:35 INFO - Successfully installed mozsystemmonitor 15:17:35 INFO - Cleaning up... 15:17:35 INFO - Return code: 0 15:17:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:35 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:35 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 15:17:35 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 15:17:35 INFO - Using env: {'DISPLAY': ':0', 15:17:35 INFO - 'HOME': '/home/cltbld', 15:17:35 INFO - 'LANG': 'en_US.UTF-8', 15:17:35 INFO - 'LANGUAGE': 'en_US:en', 15:17:35 INFO - 'LOGNAME': 'cltbld', 15:17:35 INFO - 'MAIL': '/var/mail/cltbld', 15:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:35 INFO - 'MOZ_NO_REMOTE': '1', 15:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:35 INFO - 'NO_EM_RESTART': '1', 15:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:35 INFO - 'PWD': '/builds/slave/test', 15:17:35 INFO - 'SHELL': '/bin/bash', 15:17:35 INFO - 'SHLVL': '1', 15:17:35 INFO - 'TERM': 'linux', 15:17:35 INFO - 'TMOUT': '86400', 15:17:35 INFO - 'USER': 'cltbld', 15:17:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:35 INFO - '_': '/tools/buildbot/bin/python'} 15:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:37 INFO - warning: no files found matching '*.txt' 15:17:37 INFO - no previously-included directories found matching 'build' 15:17:37 INFO - no previously-included directories found matching 'dist' 15:17:37 INFO - no previously-included directories found matching '.git*' 15:17:37 INFO - Installing collected packages: jsonschema, functools32 15:17:37 INFO - Running setup.py install for functools32 15:17:37 INFO - warning: no files found matching '*.txt' 15:17:37 INFO - no previously-included directories found matching 'build' 15:17:37 INFO - no previously-included directories found matching 'dist' 15:17:37 INFO - no previously-included directories found matching '.git*' 15:17:37 INFO - Successfully installed jsonschema functools32 15:17:37 INFO - Cleaning up... 15:17:37 INFO - Return code: 0 15:17:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:37 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 15:17:37 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 15:17:37 INFO - Using env: {'DISPLAY': ':0', 15:17:37 INFO - 'HOME': '/home/cltbld', 15:17:37 INFO - 'LANG': 'en_US.UTF-8', 15:17:37 INFO - 'LANGUAGE': 'en_US:en', 15:17:37 INFO - 'LOGNAME': 'cltbld', 15:17:37 INFO - 'MAIL': '/var/mail/cltbld', 15:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:37 INFO - 'MOZ_NO_REMOTE': '1', 15:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:37 INFO - 'NO_EM_RESTART': '1', 15:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:37 INFO - 'PWD': '/builds/slave/test', 15:17:37 INFO - 'SHELL': '/bin/bash', 15:17:37 INFO - 'SHLVL': '1', 15:17:37 INFO - 'TERM': 'linux', 15:17:37 INFO - 'TMOUT': '86400', 15:17:37 INFO - 'USER': 'cltbld', 15:17:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:37 INFO - '_': '/tools/buildbot/bin/python'} 15:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:39 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 15:17:39 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 15:17:39 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 15:17:39 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 15:17:39 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 15:17:39 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 15:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 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 15:17:40 INFO - Downloading docopt-0.6.1.tar.gz 15:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:40 INFO - Running setup.py install for blobuploader 15:17:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:40 INFO - Running setup.py install for requests 15:17:40 INFO - Running setup.py install for docopt 15:17:40 INFO - Successfully installed blobuploader requests docopt 15:17:40 INFO - Cleaning up... 15:17:41 INFO - Return code: 0 15:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:41 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 15:17:41 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 15:17:41 INFO - Using env: {'DISPLAY': ':0', 15:17:41 INFO - 'HOME': '/home/cltbld', 15:17:41 INFO - 'LANG': 'en_US.UTF-8', 15:17:41 INFO - 'LANGUAGE': 'en_US:en', 15:17:41 INFO - 'LOGNAME': 'cltbld', 15:17:41 INFO - 'MAIL': '/var/mail/cltbld', 15:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:41 INFO - 'MOZ_NO_REMOTE': '1', 15:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:41 INFO - 'NO_EM_RESTART': '1', 15:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:41 INFO - 'PWD': '/builds/slave/test', 15:17:41 INFO - 'SHELL': '/bin/bash', 15:17:41 INFO - 'SHLVL': '1', 15:17:41 INFO - 'TERM': 'linux', 15:17:41 INFO - 'TMOUT': '86400', 15:17:41 INFO - 'USER': 'cltbld', 15:17:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:41 INFO - '_': '/tools/buildbot/bin/python'} 15:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:41 INFO - Running setup.py (path:/tmp/pip-rUIUuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:41 INFO - Running setup.py (path:/tmp/pip-W4wNO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:41 INFO - Running setup.py (path:/tmp/pip-Qy5n4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:41 INFO - Running setup.py (path:/tmp/pip-m4eXgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:41 INFO - Running setup.py (path:/tmp/pip-qjJ2KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:41 INFO - Running setup.py (path:/tmp/pip-YkU0cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:41 INFO - Running setup.py (path:/tmp/pip-OzbHAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:41 INFO - Running setup.py (path:/tmp/pip-JFtKeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:41 INFO - Running setup.py (path:/tmp/pip-n2zl2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:41 INFO - Running setup.py (path:/tmp/pip-TE3XRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:42 INFO - Running setup.py (path:/tmp/pip-tEfcDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:42 INFO - Running setup.py (path:/tmp/pip-Ca6tl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:42 INFO - Running setup.py (path:/tmp/pip-aoPYnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:42 INFO - Running setup.py (path:/tmp/pip-9_O_Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:42 INFO - Running setup.py (path:/tmp/pip-oKXlA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:42 INFO - Running setup.py (path:/tmp/pip-OEMBKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:42 INFO - Running setup.py (path:/tmp/pip-Nb1if6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:42 INFO - Running setup.py install for manifestparser 15:17:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozcrash 15:17:42 INFO - Running setup.py install for mozdebug 15:17:42 INFO - Running setup.py install for mozdevice 15:17:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozfile 15:17:43 INFO - Running setup.py install for mozhttpd 15:17:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozinfo 15:17:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozInstall 15:17:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozleak 15:17:43 INFO - Running setup.py install for mozlog 15:17:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for moznetwork 15:17:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozprocess 15:17:43 INFO - Running setup.py install for mozprofile 15:17:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozrunner 15:17:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozscreenshot 15:17:44 INFO - Running setup.py install for moztest 15:17:44 INFO - Running setup.py install for mozversion 15:17:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:44 INFO - Cleaning up... 15:17:44 INFO - Return code: 0 15:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:44 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:44 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 15:17:44 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 15:17:44 INFO - Using env: {'DISPLAY': ':0', 15:17:44 INFO - 'HOME': '/home/cltbld', 15:17:44 INFO - 'LANG': 'en_US.UTF-8', 15:17:44 INFO - 'LANGUAGE': 'en_US:en', 15:17:44 INFO - 'LOGNAME': 'cltbld', 15:17:44 INFO - 'MAIL': '/var/mail/cltbld', 15:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:44 INFO - 'MOZ_NO_REMOTE': '1', 15:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:44 INFO - 'NO_EM_RESTART': '1', 15:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:44 INFO - 'PWD': '/builds/slave/test', 15:17:44 INFO - 'SHELL': '/bin/bash', 15:17:44 INFO - 'SHLVL': '1', 15:17:44 INFO - 'TERM': 'linux', 15:17:44 INFO - 'TMOUT': '86400', 15:17:44 INFO - 'USER': 'cltbld', 15:17:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:44 INFO - '_': '/tools/buildbot/bin/python'} 15:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:44 INFO - Running setup.py (path:/tmp/pip-z0AszY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:44 INFO - Running setup.py (path:/tmp/pip-9LhRm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:44 INFO - Running setup.py (path:/tmp/pip-iWa4P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:44 INFO - Running setup.py (path:/tmp/pip-LpiUmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:44 INFO - Running setup.py (path:/tmp/pip-CEx73s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:44 INFO - Running setup.py (path:/tmp/pip-RfwJT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:44 INFO - Running setup.py (path:/tmp/pip-OH7zDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:45 INFO - Running setup.py (path:/tmp/pip-w4bCXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:45 INFO - Running setup.py (path:/tmp/pip-PjYtmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:45 INFO - Running setup.py (path:/tmp/pip-r7VrLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:45 INFO - Running setup.py (path:/tmp/pip-6iOBdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:45 INFO - Running setup.py (path:/tmp/pip-4lY3FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:45 INFO - Running setup.py (path:/tmp/pip-KyMfso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:45 INFO - Running setup.py (path:/tmp/pip-6MLXNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:45 INFO - Running setup.py (path:/tmp/pip-eazWOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:45 INFO - Running setup.py (path:/tmp/pip-Zm3axm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:45 INFO - Running setup.py (path:/tmp/pip-1qDcCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:45 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 15:17:45 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 15:17:45 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 15:17:45 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 15:17:45 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 15:17:45 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 15:17:47 INFO - Downloading blessings-1.6.tar.gz 15:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:47 INFO - Installing collected packages: blessings 15:17:47 INFO - Running setup.py install for blessings 15:17:47 INFO - Successfully installed blessings 15:17:47 INFO - Cleaning up... 15:17:47 INFO - Return code: 0 15:17:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:48 INFO - Reading from file tmpfile_stdout 15:17:48 INFO - Current package versions: 15:17:48 INFO - argparse == 1.2.1 15:17:48 INFO - blessings == 1.6 15:17:48 INFO - blobuploader == 1.2.4 15:17:48 INFO - docopt == 0.6.1 15:17:48 INFO - functools32 == 3.2.3-2 15:17:48 INFO - jsonschema == 2.5.1 15:17:48 INFO - manifestparser == 1.1 15:17:48 INFO - mozInstall == 1.12 15:17:48 INFO - mozcrash == 0.17 15:17:48 INFO - mozdebug == 0.1 15:17:48 INFO - mozdevice == 0.48 15:17:48 INFO - mozfile == 1.2 15:17:48 INFO - mozhttpd == 0.7 15:17:48 INFO - mozinfo == 0.9 15:17:48 INFO - mozleak == 0.1 15:17:48 INFO - mozlog == 3.2 15:17:48 INFO - moznetwork == 0.27 15:17:48 INFO - mozprocess == 0.23 15:17:48 INFO - mozprofile == 0.28 15:17:48 INFO - mozrunner == 6.12 15:17:48 INFO - mozscreenshot == 0.1 15:17:48 INFO - mozsystemmonitor == 0.3 15:17:48 INFO - moztest == 0.7 15:17:48 INFO - mozversion == 1.4 15:17:48 INFO - psutil == 3.1.1 15:17:48 INFO - requests == 1.2.3 15:17:48 INFO - wsgiref == 0.1.2 15:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:48 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')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:48 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 15:17:48 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 15:17:48 INFO - Using env: {'DISPLAY': ':0', 15:17:48 INFO - 'HOME': '/home/cltbld', 15:17:48 INFO - 'LANG': 'en_US.UTF-8', 15:17:48 INFO - 'LANGUAGE': 'en_US:en', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MAIL': '/var/mail/cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SHLVL': '1', 15:17:48 INFO - 'TERM': 'linux', 15:17:48 INFO - 'TMOUT': '86400', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - '_': '/tools/buildbot/bin/python'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 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)) 15:17:48 INFO - Cleaning up... 15:17:48 INFO - Return code: 0 15:17:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:48 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')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:48 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 15:17:48 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 15:17:48 INFO - Using env: {'DISPLAY': ':0', 15:17:48 INFO - 'HOME': '/home/cltbld', 15:17:48 INFO - 'LANG': 'en_US.UTF-8', 15:17:48 INFO - 'LANGUAGE': 'en_US:en', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MAIL': '/var/mail/cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SHLVL': '1', 15:17:48 INFO - 'TERM': 'linux', 15:17:48 INFO - 'TMOUT': '86400', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - '_': '/tools/buildbot/bin/python'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:17:48 INFO - Cleaning up... 15:17:48 INFO - Return code: 0 15:17:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:17:48 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')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x7f06e1e82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', '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 15:17:48 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 15:17:48 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 15:17:48 INFO - Using env: {'DISPLAY': ':0', 15:17:48 INFO - 'HOME': '/home/cltbld', 15:17:48 INFO - 'LANG': 'en_US.UTF-8', 15:17:48 INFO - 'LANGUAGE': 'en_US:en', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MAIL': '/var/mail/cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SHLVL': '1', 15:17:48 INFO - 'TERM': 'linux', 15:17:48 INFO - 'TMOUT': '86400', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - '_': '/tools/buildbot/bin/python'} 15:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:48 INFO - Downloading/unpacking flake8 15:17:48 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 15:17:48 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 15:17:48 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 15:17:48 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 15:17:48 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 15:17:48 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 15:17:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:17:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:17:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:17:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:17:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:17:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:17:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:17:51 INFO - no previously-included directories found matching 'docs/_build' 15:17:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:17:51 INFO - Running setup.py install for pep8 15:17:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:17:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:17:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:17:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:17:51 INFO - no previously-included directories found matching 'docs/_build' 15:17:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:17:51 INFO - Cleaning up... 15:17:51 INFO - Return code: 0 15:17:51 INFO - Running post-action listener: _resource_record_post_action 15:17:51 INFO - Running post-action listener: _start_resource_monitoring 15:17:51 INFO - Starting resource monitoring. 15:17:51 INFO - ##### 15:17:51 INFO - ##### Finished create-virtualenv step (success) 15:17:51 INFO - ##### 15:17:51 INFO - ##### 15:17:51 INFO - ##### Running install step. 15:17:51 INFO - ##### 15:17:51 INFO - Running pre-action listener: _resource_record_pre_action 15:17:51 INFO - Running main action method: install 15:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:51 INFO - Reading from file tmpfile_stdout 15:17:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:51 INFO - Reading from file tmpfile_stdout 15:17:51 INFO - Output received: 15:17:51 INFO - Usage: mozinstall [options] installer 15:17:51 INFO - Options: 15:17:51 INFO - -h, --help show this help message and exit 15:17:51 INFO - -d DEST, --destination=DEST 15:17:51 INFO - Directory to install application into. [default: 15:17:51 INFO - "/builds/slave/test"] 15:17:51 INFO - --app=APP Application being installed. [default: firefox] 15:17:51 INFO - mkdir: /builds/slave/test/build/application 15:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:18:05 INFO - Reading from file tmpfile_stdout 15:18:05 INFO - Output received: 15:18:05 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:05 INFO - Running post-action listener: _resource_record_post_action 15:18:05 INFO - ##### 15:18:05 INFO - ##### Finished install step (success) 15:18:05 INFO - ##### 15:18:05 INFO - ##### 15:18:05 INFO - ##### Running run-tests step. 15:18:05 INFO - ##### 15:18:05 INFO - Running pre-action listener: _resource_record_pre_action 15:18:05 INFO - Running main action method: run_tests 15:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:05 INFO - Python 2.7.3 15:18:05 INFO - Return code: 0 15:18:05 INFO - grabbing minidump binary from tooltool 15:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:18:05 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 0x184e2e0>, '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 0x17ba140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ba5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:05 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 15:18:05 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 15:18:05 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 15:18:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:05 INFO - Return code: 0 15:18:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:06 INFO - Return code: 0 15:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 15:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 15:18:06 INFO - Using env: {'DISPLAY': ':0', 15:18:06 INFO - 'HOME': '/home/cltbld', 15:18:06 INFO - 'LANG': 'en_US.UTF-8', 15:18:06 INFO - 'LANGUAGE': 'en_US:en', 15:18:06 INFO - 'LOGNAME': 'cltbld', 15:18:06 INFO - 'MAIL': '/var/mail/cltbld', 15:18:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:06 INFO - 'MOZ_NO_REMOTE': '1', 15:18:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:06 INFO - 'NO_EM_RESTART': '1', 15:18:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:06 INFO - 'PWD': '/builds/slave/test', 15:18:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:06 INFO - 'SHELL': '/bin/bash', 15:18:06 INFO - 'SHLVL': '1', 15:18:06 INFO - 'TERM': 'linux', 15:18:06 INFO - 'TMOUT': '86400', 15:18:06 INFO - 'USER': 'cltbld', 15:18:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312', 15:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:06 INFO - '_': '/tools/buildbot/bin/python'} 15:18:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 15:18:06 INFO - mozversion application_buildid: 20160801123750 15:18:06 INFO - mozversion application_changeset: 3998308ce6053f95dbb3bd814a72eaafb7b31fae 15:18:06 INFO - mozversion application_display_name: Firefox 15:18:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:06 INFO - mozversion application_name: Firefox 15:18:06 INFO - mozversion application_remotingname: firefox 15:18:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:18:06 INFO - mozversion application_vendor: Mozilla 15:18:06 INFO - mozversion application_version: 49.0 15:18:06 INFO - mozversion platform_buildid: 20160801123750 15:18:06 INFO - mozversion platform_changeset: 3998308ce6053f95dbb3bd814a72eaafb7b31fae 15:18:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:18:06 INFO - mozversion platform_version: 49.0 15:18:06 INFO - using testdate: 1470089886 15:18:06 INFO - actual date: 1470089886 15:18:06 INFO - starting webserver on 'localhost:49094' 15:18:06 INFO - SUITE-START | Running 2 tests 15:18:06 INFO - TEST-START | dromaeo_css 15:18:06 INFO - operating with platform_type : linux_ 15:18:06 INFO - Initialising browser for dromaeo_css test... 15:18:06 INFO - TEST-INFO | started process 22637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7q7Htq/profile http://localhost:49094/getInfo.html) 15:18:10 INFO - PROCESS | 22637 | __metrics Screen width/height:1600/1200 15:18:10 INFO - PROCESS | 22637 | colorDepth:24 15:18:10 INFO - PROCESS | 22637 | Browser inner width/height: 1024/697 15:18:10 INFO - PROCESS | 22637 | __metrics 15:18:11 ERROR - PROCESS | 22637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:18:11 INFO - TEST-INFO | 22637: exit 0 15:18:11 INFO - Browser initialized. 15:18:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:11 INFO - TEST-INFO | started process 22764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7q7Htq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:23 INFO - PROCESS | 22764 | RSS: Main: 152543232 15:18:23 INFO - PROCESS | 22764 | 15:19:13 INFO - PROCESS | 22764 | 1470089953314 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] 15:21:21 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49094/tests/dromaeo/cssquery-ext.html) 15:21:22 INFO - PROCESS | 22764 | RSS: Main: 157011968 15:21:22 INFO - PROCESS | 22764 | 15:24:24 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-ext.html (next: http://localhost:49094/tests/dromaeo/cssquery-jquery.html) 15:24:24 INFO - PROCESS | 22764 | RSS: Main: 155275264 15:24:24 INFO - PROCESS | 22764 | 15:27:26 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49094/tests/dromaeo/cssquery-mootools.html) 15:27:27 INFO - PROCESS | 22764 | RSS: Main: 154701824 15:27:27 INFO - PROCESS | 22764 | 15:30:28 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49094/tests/dromaeo/cssquery-prototype.html) 15:30:29 INFO - PROCESS | 22764 | RSS: Main: 156016640 15:30:29 INFO - PROCESS | 22764 | 15:33:31 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49094/tests/dromaeo/cssquery-yui.html) 15:33:32 INFO - PROCESS | 22764 | RSS: Main: 154144768 15:33:32 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | Cycle 1(1): loaded http://localhost:49094/tests/dromaeo/cssquery-yui.html (next: http://localhost:49094/tests/dromaeo/cssquery-dojo.html) 15:36:34 INFO - PROCESS | 22764 | RSS: Main: 158466048 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | __start_tp_report 15:36:34 INFO - PROCESS | 22764 | _x_x_mozilla_page_load 15:36:34 INFO - PROCESS | 22764 | _x_x_mozilla_page_load_details 15:36:34 INFO - PROCESS | 22764 | |i|pagename|runs| 15:36:34 INFO - PROCESS | 22764 | |0;dojo.html;3312.2878581105065;3345.6988871001604;3373.69636732694;3384.8476818543163;3388.0174749322705;5542.674614152233;5561.527270182034;5578.665280083198;5604.831855044345;5625.915611265824;5562.638428502155;5583.748731307091;5599.8600034999145;5602.691851948141;5612.971935140318;5048.141815891298;5113.744312784346;5124.871878203037;5142.871428214287;5171.7672704728375;4980.4272508661425;5005.849824505271;5158.535731784139;5177.430482646924;5193.870153246161;4996.650234483587;5013.548780609744;5038.5969122470115;5060.4686507916695;5062.443131255559;5043.546080852722;5096.3884333879805;5114.232865070232;5117.769700363493;5132.999065182291;4882.292067650171;4899.28960300758;5017.573506251973;5029.220470827027;5081.822136225214;5361.437049109865;5433.239346491494;5475.589330800206;5481.808136715235;5520.66875987442;5967.731452084667;6015.398460153993;6024.879502409927;6025.276966763972;6047.637141771508;5782.2483077199695;5941.910871336933;6011.969940150315;6050.515958723336;6068.453839154453;5648.01159797038;5649.830505084854;5659.037963546207;5665.830025099253;5686.346070201897;6179.84550386235;6185.288691800411;6188.257409110845;6191.721372538246;6193.163922870445;5687.4596913294;5773.422657734277;5788.855278618068;5820.592558520948;5920.644761314335;5963.79126730571;5967.6419414835245;5973.1338955852025;5979.312379076375;5980.641161530322;5895.233619629506;5931.228940237827;5933.910991335047;5953.76184952597;5962.19510366095;5813.157092221604;5892.970535147382;5911.970440147772;5953.910691339634;5958.195643588147;4579.977100114478;4580.1755683976535;4608.976955115203;4615.769211539409;4621.514740952219;4101.7744024078365;4110.815013324408;4132.690048246393;4134.710570260053;4162.875113746592;5656.547476201894;5726.656400615976;5777.740001699934;5862.853428664317;5890.352061273256;6062.545309101835;6080.118382834465;6083.908741368883;6085.2393450818645;6112.541559383064;5675.120356344773;5750.137479378043;5758.539316854642;5813.709314534256;5827.737751801179;5130.948690513047;5159.922601160985;5170.97414512925;5206.062908676399;5207.895842083213;6237.781677641261;6257.655828929362;6268.247810262797;6269.592476489013;6277.246730392382;6027.0356742921795;6040.1241819934985;6052.66710330936;6054;6061.272647282354;6080.209572755691;6195.783147589813;6264.812055638338;6280.780172693934;6383.106365108982;5997.880042399215;5998.550108741949;6009.278886533644;6024.186734790747;6024.518038556993;5847.707614619337;6077.5745697802495;6081.5742897996715;6096.177016102769;6107.84730381744;5802.897449484584;5821.592488525763;5857.4435428634215;5887.3523912370465;5918.940810591839;5822.883542329215;5839.445252700986;5840.328362238397;5847.970760146172;5853.970730146322;5669.433056694297;5725.770969161187;5779.537636989115;5787.8553036174435;5793.449622285876;5846.123081537803;5873.706314684163;5912;5926.407359264039;5946.048632218824;5795.710214489174;5807.709614519173;5847.619904706181;5848.2689663792025;5863.589548731718 15:36:34 INFO - PROCESS | 22764 | |1;ext.html;596.3291297290548;633.0535848905885;639.2233436374804;655.0861548140344;657.1325849878161;37171.814140929295;45644;46503;46686.76656616716;49901.25148122781;47491.28763068548;47632.28551571729;48106;48122.315718949845;48275.75862120693;8996.91003089969;9166.312526560501;9194.770130746718;9195.988441271455;9232.399894006901;9029.23251523618;9064.954675226614;9088.954555227248;9147.085291470832;9170.266378689723;9147.54262286883;9180;9181.908180918206;9182.724518264462;9218.86171707425;9111.271098312152;9198;9202.263818894473;9206.355555111146;9212.216961558275;9010.59452324647;9095.81808363829;9097.909020909772;9101.863472047924;9114.954425227832;44325;44393.77803110996;44777.32834007493;44875;44888;3546.219831637036;3728.9440658390145;3844.519435070616;3928.744631598937;4391.516933137353;33915;34295;34412.655873441196;34520.654793452;34609.653903460894;4794.37673102498;4807.471178170398;4843.612510999112;4894.877628059291;4954.851354459372;339332;342143;342182;343203;343956;33947.83026084854;34903.82548087294;65530;65549.6722516394;65898.67050664716;38268;38808.80595597004;38885.666859988494;38950.610493894696;38974.61025389766;14106.788398174036;14201.218932958787;14236.715265694627;14244.715105697827;14287.85712142886;10953.780924381468;10976.615818446317;11066.944665276622;11074.667759967213;11132.944335278435;9107.180353768194;9121.863172052424;9197.264218862474;9200.815983680423;9224.215941645036;3518.5953615334565;3542.0436482149676;3605.3149901518627;3607.5129857469433;3618.9276214475562;1054.6150655010865;1071.9464026798628;1086.473060565625;1117.3966058328413;1207.0464333176692;31148;32083.839580802414;32228.516572251436;32798.01605951777;32931.67068329334;1127.8421021057059;1161.5992482593492;1174.9823752643717;1214.1440284599337;1232.1805999010737;16920.57698557521;16962.745558816627;17041.062741549333;17235.588150533007;17318.740218896728;154984;842030;859673;861685;972489;59656.403435965956;60102.699486502286;60484.69757651183;60568.39431605628;60634;1425.4298280687808;1454.6872422429228;1472.2785834941017;1480.267267702494;1487.516557118919;31619;32607.510887336233;32782.50826237656;32896.83551582227;33308.66691333152;51894;52190;52471.73764131155;52558.211626824865;52559.47440525546;421413;422945;423009;424077;425305;29890.850545748002;29993.70006299909;30120.548191776703;30308.545371819;30354.392912142077;47021.48681150843;47924.7603761979;47941.04117917692;48086.759566201945;48139.277910830664;39727.80136099301;40168;40472.3929141069;40618;41568.376474352306;39594;39704.404433932934;40219.39670904997;40469.797651011555;41137.79431102825;40035.59964400319;40257.396139058525;41074;41119.794401029;41236.79381603073;35669.82165089158;36491;37351.43972840464;37355.439668404455;37397.065073373386;28260.576091358234;28841.71158288474;28874.566881496376;28912;29062 15:36:34 INFO - PROCESS | 22764 | |2;jquery.html;396.2589956780819;402.12337105110845;403.2358680300829;410.0855093142293;412.3073236961904;16501.0924399158;18797.248110075598;20038.699419508717;20427.591448171046;20444.386668399955;12338.753224935519;12529;12556.434960426779;18606.418454431358;18739.43781686548;5372.865678358043;5522.0336441122845;5538.944610553904;5542.39033706292;5775.971120144393;6063.029915213567;6074.453299203071;6138.570300078996;6143.139960405547;6144.41628045335;5930.822075337746;6089.939100608982;6118.357572454895;6119.969400152993;6147.72335244915;6073.331933487335;6085.9695701521205;6092.421219984139;6121.816345509619;6129.570930034899;5773.307203135609;5978.40215978403;5983.222181116471;5994.040953447471;6038.516918646542;14306.356213970397;14618.195999220039;18101.54746131344;24070.277891663278;24260.514789704284;2353.870537120458;2370.917017904382;2390.71311442628;2448.4980578981267;2810.325521874756;10443.95560443957;10493.737656558571;10566.735831604194;10742.194335424874;10786.137109031259;2022.0092154844167;2028.1785876719953;2031.3093548193538;2057.584409879593;2092.529180934293;79083.60458197672;79514;79567.80648290222;80103.79584816658;84204.57897710534;10747;11116.944415278034;11485.942570287261;11712.765744685059;11855.881441185651;16630.66738665244;16690.66618667644;16735.414260500824;16799.748003779954;16817.57956051084;7755.457118001686;8044.195580442026;8108;8166.877496837552;8237.83524329522;7477.252274772588;7490.176080631126;7579.848403031909;7692.46152769312;7715.267049630276;4880.389951256093;5024.748762561857;5061.620378471629;5169.53474187325;5175;2060.721802556666;2083.7395325584303;2092.7070210170587;2105.094809232014;2108.704781330615;943.4339396362265;970.96601618943;1030.5208078243652;1065.3022270412891;1081.0972837680467;17944.730829037573;19017.14422850975;19731.40805775829;19926.402207933785;19971.301004465065;1000.1548691355792;1016.1413605503337;1070.662741236508;1089.4824958144818;1102.72431892027;10637.521311540999;10764.946175269073;10905.291156074989;10920.18098642589;11088;495854;496807;502487;502744;508563;69414.65292673504;71208.64395678091;99462.50268748609;99938;100080;1035.6737627647267;1050.4275170032352;1056.1920131099714;1060.0247772049734;1063.0538820449806;17341.73987390165;17530.91234543819;17593.472195834147;17672.823271767116;17803.55491112681;39726;41764.582354177284;42097;42533.57466425296;43263.56736432595;57496.42503575078;60009.69995150171;60325.69837150786;60468.69765651144;60577.69711151416;7969.163237859942;8776.956115219384;8816.867746983671;9059.094090590888;9274.814503709753;13257.403416846073;13492.257925814174;13612.65968350799;13662;13689.931550342184;9347.766305842408;10587.629432970118;12013.339266340086;12058.216215946286;12167.330796805907;11616.361100139573;11806.881931180922;11863;12001.15991880595;12150.635480935585;11771.646850594496;12183;12296.508139674313;12436.316002619942;12505.874941250471;8211.83576328482;8387.245147936716;8426.705065322683;8433.409661323649;8439.789005274917;11802.52789888395;12142.150049496451;12145.210561313486;12183.573574924834;12452.750944981231 15:36:34 INFO - PROCESS | 22764 | |3;mootools.html;1542.113284861205;1562.4765703489331;1753.7457068725034;1868.392772348987;1892.7350170976065;8930.55347232639;9504.097110774483;9525.571349289272;9543.61825526979;9710.70867873965;9832.164266037378;9837;9998.10017098461;9999.250056245774;10007.049330313608;2464.8028157747426;2499.487605040962;2499.912503062393;2505.912293069734;2506.410993416546;2435.391152211947;2506.0727530813624;2509.6737424134835;2514.346269969812;2521.306640673811;2454.3250606083293;2459.631055341695;2517.45874636953;2518.1941778630844;2519.1938579654516;2422.1401402502124;2427.3446169534213;2434.5982912819454;2464.8521088734556;2474.9010039598393;2355.093289083698;2384.666146739458;2388.7611238876148;2391.629297458897;2439.560879041772;9692.563834627388;9749.220062394992;9750.658726944594;9790.5594248259;9799.16707079899;5426.67439953604;5505.256790333294;5552.111662134039;5555.749991250363;5561.388247292794;3498;3551.3785087609567;3608.350496910555;3687.797171155585;3704.240630670733;1187.1155988788407;1201.543413502872;1206.6561030106377;1223.5839814463036;1233.802591585351;13521.526746563823;13632.386542605607;13635.250061246727;13648.93175534116;13675;4506.278995360726;4618.30725391194;4625.907481850411;4628.83799067031;4641.350210970467;10381.584736610452;10382.636607718694;10448.582056717647;10463.84304235437;10468.52891619879;5204.635675502678;5300.072487314705;5490.6431081979545;5511.696856672921;5522.088855338824;4830.6135509159185;4983.8006479741125;4995.500449955048;5025.346704928336;5137.486251374833;4106.589341065869;4117.629413352753;4119.949412899751;4169.583041695867;4181.184668989578;1100.4442756407964;1117.7485065860117;1123.9325640461598;1132.1565433751744;1176.3471273443322;909.5634095634133;1004.4224570871778;1005.0903931941605;1005.7988402319565;1019.9745006374751;5865.501432378211;6020.759169633253;6143.96928015357;6183.103449999725;6272.5922815016875;471.5873610590733;474.5302150870613;479.56838845039744;486.1346802691145;486.8247430924864;4438.866833994921;4466.59800617946;4562.498125206224;4627.676062675648;4636.559526844944;11719.648410547697;12160.817587736014;12243.449044793006;12278.815817762741;12332.260064396165;11824.822627660593;12210.389480525939;12231.510739570496;12256.264624122581;12257.448414821354;8815.162559556831;8835.381523293436;8855.91144088551;9045.592948317473;9125.406848554823;6444.45222156122;6542.228793199016;6580.1116849224745;6655.134832471747;6681.997700344987;11056.557737690402;11257.662270131581;11328.263662861887;11366.147538934778;11413.372264525531;11156.330620162817;11314.264572802742;11416.086713063101;11485.885141148481;11502.079833613123;7118.9644051779405;7855.960720196591;8002.079760827346;8125.309348705427;8200.917990820255;9462.337636365388;9489.952550237205;9504.85742713846;9518.904810952079;9571.042895710374;7997.120316765035;8236.711715089943;8288.129746376784;8308.833823323379;8554.144585541397;7993.360531157377;8041.236082572146;8205.58972051407;8219.178082191733;8417.873731893904;7656.693732250647;7664.655090520829;7775.377969762519;7776.105747838845;7794.454388192772;5507.9449205507435;5518.779248830002;5611.130274807411;5698.088305871206;5703.914441283467;5493.340799104133;5584.134459158837;5622.128570071645;5692.459216374438;5701.116326969326 15:36:34 INFO - PROCESS | 22764 | |4;prototype.html;310.4365576478691;313.7098184179634;314.115764123991;324.4873100501208;327.8491893728885;5598.692071936042;5633.15502674599;5833.183354330392;5834.679092649908;5844.386339434362;5702.914456283149;5710.828675139753;5722.513586345166;5733.935783118084;5739.139129130633;4374.58441448062;4379.430674012374;4389.802458889358;4396.758178300192;4412.624926881219;4246.506464347767;4277.443932288814;4360.171567402199;4370;4370.73775573465;4273.615374616284;4283.614474697277;4291.506476755182;4329.41976178694;4334.523202447728;4323.41633879427;4334.848280310174;4336.354823557627;4341.587549182823;4359.32430473274;3581;3687.3547129252274;3690.280395322913;3691.1325838427947;3694.2796154749835;5471.781128754845;5473.589480788957;5482.396936337;5485.341758988947;5486.862828429281;4898.779554920037;4909.533594308571;4913.606911447076;4929.088118698017;4930.753462326869;5745.368009518949;5931.317898441691;5956.55325850563;5985.730642121115;6008.399160084;4083.8774836754947;4084.5711200323835;4085.3259212229946;4088.468499095128;4093.7923312622847;5981.9401805981815;6089.786857460012;6173.59871608344;6180.887440260752;6191.668791209867;4246.5753424657905;4262.104957958802;4265.76538290397;4269.5516970718245;4287.7641729705165;4309.353596960481;4323.265044942367;4340.348947657877;4361.956380436155;4368.694191406635;5036.697798132123;5041.269015992734;5042.168042273057;5045.082868509943;5067.543921047123;5828.892510423006;5847.158145184253;5975.940240597625;5990.970045149834;6037.516998640186;1470.9117452952858;1485.1237769715704;1491.2171110167033;1495.0879963222426;1500.4148382130977;903.4534106865383;920.4569304110607;923.7413524213231;927.5223260021095;930.4742820306506;5203.557697595671;5212.609054320941;5224.634275600672;5228.398734145546;5230;5405.78376864921;5466.972665136649;5490.588205884575;5505.916686655406;5535.754455247617;5023.497650234947;5224.216367544898;5238.60710446718;5253.553447956967;5258.395284542326;2932.4428358611794;2934.53047512397;2937.221636266391;2945.042861070118;2974.4943359628915;5649.265595472644;5662.546996240291;5673.943260567424;5684.971575142098;5709.229254050733;5245.318108645852;5526.143447765603;5529.889402212014;5531.865967476658;5554.666719996732;5630.9019741150905;5644.6330988485615;5667.4332566743;5680.346760122557;5687.9431205687415;5276.419593844597;5350.9732451337495;5517.2275881377445;5536;5587.69267690281;5372.382176049804;5389.380221274603;5492.379747974437;5493.395726470165;5503.394626591152;5566.777328906798;5594.293740409052;5598.776048957996;5601.60788744784;5644.774209031592;3651.9269614608093;3877.1470276539117;3889.2999260133447;3894.435306880543;3919.8824035278985;5383.515483606494;5488.807891723771;5510.6969116698965;6080.4831589313635;6200.410960958882;6060;6060.939390606038;6061.121052473747;6083.117947897442;6085.2393450818645;6065.332813390612;6070.848228794139;6078.635281883101;6122.234720659918;6158;5703.315602127771;5966.970165149147;6027.095935609694;6046.183765191643;6050.2437195350585;6117;6179.455136215946;6187.535934804998;6188.44304012641;6196.566240363131;5663.8867222656145;5966.866295403859;6033.577649564489;6039.456448919443;6044.879102418015 15:36:34 INFO - PROCESS | 22764 | |5;yui.html;759.623986126867;786.9567173805442;814.4828034198282;889.5685592487642;917.7705573606601;14463.421463141474;15110.093394396345;15488.457903973363;15874;16199.676006479864;13174.538891138813;13322.666933326671;13446.193228406279;13515;13602.795958060637;833.6165363932568;843.4433274039135;854.8162145138793;856.8372009318241;858.1247127929508;857.8927634045745;858.3862538285125;860.1226748716336;860.3418384935529;863.4258218284864;903.4940433357308;905.5427009360263;905.959231834569;909.4316052467208;910.6812615584525;899.3434792601372;901.2744740483907;901.625825282507;904.3398319226935;904.7240591619553;661.7220767277706;661.8312330355728;664.309118516742;665.1320027364287;667.5694177255691;15322.693546129016;15479.07125572458;15496.070235785775;15513.457029004043;15604.60988475286;13632.318384080856;13634.045616806827;13673.111247768864;13682.452701891913;13778.311084445837;11580.247283926603;11705.53177872884;11738.413079346084;11802.232854864405;11965.162438629299;3882.8835134945716;3886.514185726784;3917.4319723640197;3921.215756848642;3970;82147.58926205331;82334;82982.58508707478;83378;83454;10496.737581560523;10847.02376786093;10873.83689244662;11075.390853502973;11125.332480051224;18959.810401895804;19012;19089.331873384366;19097.904510477638;19191.424257272025;8149.877751833727;8255.339572834158;8263.710770123016;8304.958475207586;8438.409311348147;4839.249916262915;4994.225894986283;5024.070546948826;5037.19404895215;5078.873028174251;3417.5215469834243;3545.3618348697482;3554.3957527220437;3556.270964452281;3557.3418917500344;630.3790766095392;634.3181080338654;642.6369101457661;643.7360682120308;645.6997496164212;685.4447897203281;740.5226572986818;795.3001358804215;819.5369616166847;843.2495079379357;9850.704478865502;10106.898931010743;10257.948710256402;10335.17318614509;10490.31812932157;633.6926590603554;723.4682508356353;745.2175216023154;751.7293774241268;830.887830142923;4797;4894.535019173173;4895.4370247422;4896.216605343128;4929.186684197139;68228.65885670639;110847.44576277067;116884.41557792157;117449;118555;86937;95183.52408237914;99254.00745992592;100546.4972675132;102688.48655756674;87827.56086219529;88961.55519222491;89178;90298.54850725704;91555.54222228847;9696.175825054666;9728.923894948523;9864.556094975887;9947.751306217402;9978.800423991624;42645.36031959461;44298.55701442944;47096.29355559738;50036.49963500319;51706.48293517167;75543;75543;76288.61855690686;77731.22268777466;78909;12620.936895315464;12720.109592328448;12730.299833509245;12739.426725797546;12806.61580152597;13094.214347139203;13772.31138443094;13900.721985560434;14068.718625627225;14441.7833732492;13120.60638180856;13158.342082896008;13214;13473.393697283449;13528.458861645424;12674.049446291381;13012.349382531025;13079.738405231652;13158.802617960548;13219.339033048116;12294.446749896455;12324.753504930031;12609.117361784587;13187.67030824237;13392.196468211549;10941.945290273497;10971.122310215003;11172.345187764238;11308.830367544659;11423;11094.167937404889;11396.886031139582;11415.771684566096;11434.542618295174;11691.590794322157 15:36:34 INFO - PROCESS | 22764 | __end_tp_report 15:36:34 INFO - PROCESS | 22764 | __start_cc_report 15:36:34 INFO - PROCESS | 22764 | _x_x_mozilla_cycle_collect,332 15:36:34 INFO - PROCESS | 22764 | __end_cc_report 15:36:34 INFO - PROCESS | 22764 | __startTimestamp1470090994549__endTimestamp 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | ------- Summary: start ------- 15:36:34 INFO - PROCESS | 22764 | Number of tests: 6 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#0] dojo.html Cycles:165 Average:5578.93 Median:5807.71 stddev:627.58 (10.8%) stddev-sans-first:603.79 15:36:34 INFO - PROCESS | 22764 | Values: 3312.3 3345.7 3373.7 3384.8 3388.0 5542.7 5561.5 5578.7 5604.8 5625.9 5562.6 5583.7 5599.9 5602.7 5613.0 5048.1 5113.7 5124.9 5142.9 5171.8 4980.4 5005.8 5158.5 5177.4 5193.9 4996.7 5013.5 5038.6 5060.5 5062.4 5043.5 5096.4 5114.2 5117.8 5133.0 4882.3 4899.3 5017.6 5029.2 5081.8 5361.4 5433.2 5475.6 5481.8 5520.7 5967.7 6015.4 6024.9 6025.3 6047.6 5782.2 5941.9 6012.0 6050.5 6068.5 5648.0 5649.8 5659.0 5665.8 5686.3 6179.8 6185.3 6188.3 6191.7 6193.2 5687.5 5773.4 5788.9 5820.6 5920.6 5963.8 5967.6 5973.1 5979.3 5980.6 5895.2 5931.2 5933.9 5953.8 5962.2 5813.2 5893.0 5912.0 5953.9 5958.2 4580.0 4580.2 4609.0 4615.8 4621.5 4101.8 4110.8 4132.7 4134.7 4162.9 5656.5 5726.7 5777.7 5862.9 5890.4 6062.5 6080.1 6083.9 6085.2 6112.5 5675.1 5750.1 5758.5 5813.7 5827.7 5130.9 5159.9 5171.0 5206.1 5207.9 6237.8 6257.7 6268.2 6269.6 6277.2 6027.0 6040.1 6052.7 6054.0 6061.3 6080.2 6195.8 6264.8 6280.8 6383.1 5997.9 5998.6 6009.3 6024.2 6024.5 5847.7 6077.6 6081.6 6096.2 6107.8 5802.9 5821.6 5857.4 5887.4 5918.9 5822.9 5839.4 5840.3 5848.0 5854.0 5669.4 5725.8 5779.5 5787.9 5793.4 5846.1 5873.7 5912.0 5926.4 5946.0 5795.7 5807.7 5847.6 5848.3 5863.6 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#1] ext.html Cycles:180 Average:64563.07 Median:40471.10 stddev:150451.55 (371.8%) stddev-sans-first:150796.95 15:36:34 INFO - PROCESS | 22764 | Values: 596.3 633.1 639.2 655.1 657.1 37171.8 45644.0 46503.0 46686.8 49901.3 47491.3 47632.3 48106.0 48122.3 48275.8 8996.9 9166.3 9194.8 9196.0 9232.4 9029.2 9065.0 9089.0 9147.1 9170.3 9147.5 9180.0 9181.9 9182.7 9218.9 9111.3 9198.0 9202.3 9206.4 9212.2 9010.6 9095.8 9097.9 9101.9 9115.0 44325.0 44393.8 44777.3 44875.0 44888.0 3546.2 3728.9 3844.5 3928.7 4391.5 33915.0 34295.0 34412.7 34520.7 34609.7 4794.4 4807.5 4843.6 4894.9 4954.9 339332.0 342143.0 342182.0 343203.0 343956.0 33947.8 34903.8 65530.0 65549.7 65898.7 38268.0 38808.8 38885.7 38950.6 38974.6 14106.8 14201.2 14236.7 14244.7 14287.9 10953.8 10976.6 11066.9 11074.7 11132.9 9107.2 9121.9 9197.3 9200.8 9224.2 3518.6 3542.0 3605.3 3607.5 3618.9 1054.6 1071.9 1086.5 1117.4 1207.0 31148.0 32083.8 32228.5 32798.0 32931.7 1127.8 1161.6 1175.0 1214.1 1232.2 16920.6 16962.7 17041.1 17235.6 17318.7 154984.0 842030.0 859673.0 861685.0 972489.0 59656.4 60102.7 60484.7 60568.4 60634.0 1425.4 1454.7 1472.3 1480.3 1487.5 31619.0 32607.5 32782.5 32896.8 33308.7 51894.0 52190.0 52471.7 52558.2 52559.5 421413.0 422945.0 423009.0 424077.0 425305.0 29890.9 29993.7 30120.5 30308.5 30354.4 47021.5 47924.8 47941.0 48086.8 48139.3 39727.8 40168.0 40472.4 40618.0 41568.4 39594.0 39704.4 40219.4 40469.8 41137.8 40035.6 40257.4 41074.0 41119.8 41236.8 35669.8 36491.0 37351.4 37355.4 37397.1 28260.6 28841.7 28874.6 28912.0 29062.0 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#2] jquery.html Cycles:180 Average:29169.09 Median:2231.29 stddev:82558.00 (3700.0%) stddev-sans-first:82761.33 15:36:34 INFO - PROCESS | 22764 | Values: 396.3 402.1 403.2 410.1 412.3 16501.1 18797.2 20038.7 20427.6 20444.4 12338.8 12529.0 12556.4 18606.4 18739.4 5372.9 5522.0 5538.9 5542.4 5776.0 6063.0 6074.5 6138.6 6143.1 6144.4 5930.8 6089.9 6118.4 6120.0 6147.7 6073.3 6086.0 6092.4 6121.8 6129.6 5773.3 5978.4 5983.2 5994.0 6038.5 14306.4 14618.2 18101.5 24070.3 24260.5 2353.9 2370.9 2390.7 2448.5 2810.3 10444.0 10493.7 10566.7 10742.2 10786.1 2022.0 2028.2 2031.3 2057.6 2092.5 79083.6 79514.0 79567.8 80103.8 84204.6 10747.0 11116.9 11485.9 11712.8 11855.9 16630.7 16690.7 16735.4 16799.7 16817.6 7755.5 8044.2 8108.0 8166.9 8237.8 7477.3 7490.2 7579.8 7692.5 7715.3 4880.4 5024.7 5061.6 5169.5 5175.0 2060.7 2083.7 2092.7 2105.1 2108.7 943.4 971.0 1030.5 1065.3 1081.1 17944.7 19017.1 19731.4 19926.4 19971.3 1000.2 1016.1 1070.7 1089.5 1102.7 10637.5 10764.9 10905.3 10920.2 11088.0 495854.0 496807.0 502487.0 502744.0 508563.0 69414.7 71208.6 99462.5 99938.0 100080.0 1035.7 1050.4 1056.2 1060.0 1063.1 17341.7 17530.9 17593.5 17672.8 17803.6 39726.0 41764.6 42097.0 42533.6 43263.6 57496.4 60009.7 60325.7 60468.7 60577.7 7969.2 8777.0 8816.9 9059.1 9274.8 13257.4 13492.3 13612.7 13662.0 13689.9 9347.8 10587.6 12013.3 12058.2 12167.3 11616.4 11806.9 11863.0 12001.2 12150.6 11771.6 12183.0 12296.5 12436.3 12505.9 8211.8 8387.2 8426.7 8433.4 8439.8 11802.5 12142.2 12145.2 12183.6 12452.8 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#3] mootools.html Cycles:180 Average:6256.13 Median:4626.79 stddev:3683.17 (79.6%) stddev-sans-first:3676.47 15:36:34 INFO - PROCESS | 22764 | Values: 1542.1 1562.5 1753.7 1868.4 1892.7 8930.6 9504.1 9525.6 9543.6 9710.7 9832.2 9837.0 9998.1 9999.3 10007.0 2464.8 2499.5 2499.9 2505.9 2506.4 2435.4 2506.1 2509.7 2514.3 2521.3 2454.3 2459.6 2517.5 2518.2 2519.2 2422.1 2427.3 2434.6 2464.9 2474.9 2355.1 2384.7 2388.8 2391.6 2439.6 9692.6 9749.2 9750.7 9790.6 9799.2 5426.7 5505.3 5552.1 5555.7 5561.4 3498.0 3551.4 3608.4 3687.8 3704.2 1187.1 1201.5 1206.7 1223.6 1233.8 13521.5 13632.4 13635.3 13648.9 13675.0 4506.3 4618.3 4625.9 4628.8 4641.4 10381.6 10382.6 10448.6 10463.8 10468.5 5204.6 5300.1 5490.6 5511.7 5522.1 4830.6 4983.8 4995.5 5025.3 5137.5 4106.6 4117.6 4119.9 4169.6 4181.2 1100.4 1117.7 1123.9 1132.2 1176.3 909.6 1004.4 1005.1 1005.8 1020.0 5865.5 6020.8 6144.0 6183.1 6272.6 471.6 474.5 479.6 486.1 486.8 4438.9 4466.6 4562.5 4627.7 4636.6 11719.6 12160.8 12243.4 12278.8 12332.3 11824.8 12210.4 12231.5 12256.3 12257.4 8815.2 8835.4 8855.9 9045.6 9125.4 6444.5 6542.2 6580.1 6655.1 6682.0 11056.6 11257.7 11328.3 11366.1 11413.4 11156.3 11314.3 11416.1 11485.9 11502.1 7119.0 7856.0 8002.1 8125.3 8200.9 9462.3 9490.0 9504.9 9518.9 9571.0 7997.1 8236.7 8288.1 8308.8 8554.1 7993.4 8041.2 8205.6 8219.2 8417.9 7656.7 7664.7 7775.4 7776.1 7794.5 5507.9 5518.8 5611.1 5698.1 5703.9 5493.3 5584.1 5622.1 5692.5 5701.1 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#4] prototype.html Cycles:180 Average:4815.10 Median:5483.87 stddev:1431.94 (26.1%) stddev-sans-first:1395.47 15:36:34 INFO - PROCESS | 22764 | Values: 310.4 313.7 314.1 324.5 327.8 5598.7 5633.2 5833.2 5834.7 5844.4 5702.9 5710.8 5722.5 5733.9 5739.1 4374.6 4379.4 4389.8 4396.8 4412.6 4246.5 4277.4 4360.2 4370.0 4370.7 4273.6 4283.6 4291.5 4329.4 4334.5 4323.4 4334.8 4336.4 4341.6 4359.3 3581.0 3687.4 3690.3 3691.1 3694.3 5471.8 5473.6 5482.4 5485.3 5486.9 4898.8 4909.5 4913.6 4929.1 4930.8 5745.4 5931.3 5956.6 5985.7 6008.4 4083.9 4084.6 4085.3 4088.5 4093.8 5981.9 6089.8 6173.6 6180.9 6191.7 4246.6 4262.1 4265.8 4269.6 4287.8 4309.4 4323.3 4340.3 4362.0 4368.7 5036.7 5041.3 5042.2 5045.1 5067.5 5828.9 5847.2 5975.9 5991.0 6037.5 1470.9 1485.1 1491.2 1495.1 1500.4 903.5 920.5 923.7 927.5 930.5 5203.6 5212.6 5224.6 5228.4 5230.0 5405.8 5467.0 5490.6 5505.9 5535.8 5023.5 5224.2 5238.6 5253.6 5258.4 2932.4 2934.5 2937.2 2945.0 2974.5 5649.3 5662.5 5673.9 5685.0 5709.2 5245.3 5526.1 5529.9 5531.9 5554.7 5630.9 5644.6 5667.4 5680.3 5687.9 5276.4 5351.0 5517.2 5536.0 5587.7 5372.4 5389.4 5492.4 5493.4 5503.4 5566.8 5594.3 5598.8 5601.6 5644.8 3651.9 3877.1 3889.3 3894.4 3919.9 5383.5 5488.8 5510.7 6080.5 6200.4 6060.0 6060.9 6061.1 6083.1 6085.2 6065.3 6070.8 6078.6 6122.2 6158.0 5703.3 5967.0 6027.1 6046.2 6050.2 6117.0 6179.5 6187.5 6188.4 6196.6 5663.9 5966.9 6033.6 6039.5 6044.9 15:36:34 INFO - PROCESS | 22764 | 15:36:34 INFO - PROCESS | 22764 | [#5] yui.html Cycles:180 Average:20568.71 Median:43471.96 stddev:29825.51 (68.6%) stddev-sans-first:29872.09 15:36:34 INFO - PROCESS | 22764 | Values: 759.6 787.0 814.5 889.6 917.8 14463.4 15110.1 15488.5 15874.0 16199.7 13174.5 13322.7 13446.2 13515.0 13602.8 833.6 843.4 854.8 856.8 858.1 857.9 858.4 860.1 860.3 863.4 903.5 905.5 906.0 909.4 910.7 899.3 901.3 901.6 904.3 904.7 661.7 661.8 664.3 665.1 667.6 15322.7 15479.1 15496.1 15513.5 15604.6 13632.3 13634.0 13673.1 13682.5 13778.3 11580.2 11705.5 11738.4 11802.2 11965.2 3882.9 3886.5 3917.4 3921.2 3970.0 82147.6 82334.0 82982.6 83378.0 83454.0 10496.7 10847.0 10873.8 11075.4 11125.3 18959.8 19012.0 19089.3 19097.9 19191.4 8149.9 8255.3 8263.7 8305.0 8438.4 4839.2 4994.2 5024.1 5037.2 5078.9 3417.5 3545.4 3554.4 3556.3 3557.3 630.4 634.3 642.6 643.7 645.7 685.4 740.5 795.3 819.5 843.2 9850.7 10106.9 10257.9 10335.2 10490.3 633.7 723.5 745.2 751.7 830.9 4797.0 4894.5 4895.4 4896.2 4929.2 68228.7 110847.4 116884.4 117449.0 118555.0 86937.0 95183.5 99254.0 100546.5 102688.5 87827.6 88961.6 89178.0 90298.5 91555.5 9696.2 9728.9 9864.6 9947.8 9978.8 42645.4 44298.6 47096.3 50036.5 51706.5 75543.0 75543.0 76288.6 77731.2 78909.0 12620.9 12720.1 12730.3 12739.4 12806.6 13094.2 13772.3 13900.7 14068.7 14441.8 13120.6 13158.3 13214.0 13473.4 13528.5 12674.0 13012.3 13079.7 13158.8 13219.3 12294.4 12324.8 12609.1 13187.7 13392.2 10941.9 10971.1 11172.3 11308.8 11423.0 11094.2 11396.9 11415.8 11434.5 11691.6 15:36:34 INFO - PROCESS | 22764 | -------- Summary: end -------- 15:36:34 INFO - PROCESS | 22764 | 15:36:35 INFO - TEST-INFO | 22764: exit 0 15:36:35 INFO - TEST-OK | dromaeo_css | took 1108929ms 15:36:35 INFO - TEST-START | kraken 15:36:35 INFO - operating with platform_type : linux_ 15:36:35 INFO - Initialising browser for kraken test... 15:36:35 INFO - TEST-INFO | started process 23009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn2YeSz/profile http://localhost:49094/getInfo.html) 15:36:39 INFO - PROCESS | 23009 | __metrics Screen width/height:1600/1200 15:36:39 INFO - PROCESS | 23009 | colorDepth:24 15:36:39 INFO - PROCESS | 23009 | Browser inner width/height: 1024/697 15:36:39 INFO - PROCESS | 23009 | __metrics 15:36:39 ERROR - PROCESS | 23009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 15:36:40 INFO - TEST-INFO | 23009: exit 0 15:36:40 INFO - Browser initialized. 15:36:40 INFO - Running cycle 1/1 for kraken test... 15:36:40 INFO - TEST-INFO | started process 23133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn2YeSz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:52 INFO - PROCESS | 23133 | RSS: Main: 152817664 15:36:52 INFO - PROCESS | 23133 | 15:36:55 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49094/tests/kraken/driver.html?testName=audio-beat-detection) 15:36:55 INFO - PROCESS | 23133 | RSS: Main: 158068736 15:36:55 INFO - PROCESS | 23133 | 15:36:58 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49094/tests/kraken/driver.html?testName=audio-dft) 15:36:59 INFO - PROCESS | 23133 | RSS: Main: 157634560 15:36:59 INFO - PROCESS | 23133 | 15:37:02 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49094/tests/kraken/driver.html?testName=audio-fft) 15:37:02 INFO - PROCESS | 23133 | RSS: Main: 158420992 15:37:02 INFO - PROCESS | 23133 | 15:37:04 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49094/tests/kraken/driver.html?testName=audio-oscillator) 15:37:05 INFO - PROCESS | 23133 | RSS: Main: 157917184 15:37:05 INFO - PROCESS | 23133 | 15:37:07 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49094/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:08 INFO - PROCESS | 23133 | RSS: Main: 157691904 15:37:08 INFO - PROCESS | 23133 | 15:37:11 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49094/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:11 INFO - PROCESS | 23133 | RSS: Main: 156766208 15:37:11 INFO - PROCESS | 23133 | 15:37:15 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49094/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:15 INFO - PROCESS | 23133 | RSS: Main: 157327360 15:37:15 INFO - PROCESS | 23133 | 15:37:18 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49094/tests/kraken/driver.html?testName=json-parse-financial) 15:37:19 INFO - PROCESS | 23133 | RSS: Main: 157917184 15:37:19 INFO - PROCESS | 23133 | 15:37:20 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49094/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:21 INFO - PROCESS | 23133 | RSS: Main: 157310976 15:37:21 INFO - PROCESS | 23133 | 15:37:23 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:23 INFO - PROCESS | 23133 | RSS: Main: 157097984 15:37:23 INFO - PROCESS | 23133 | 15:37:25 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:26 INFO - PROCESS | 23133 | RSS: Main: 157691904 15:37:26 INFO - PROCESS | 23133 | 15:37:28 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:29 INFO - PROCESS | 23133 | RSS: Main: 158498816 15:37:29 INFO - PROCESS | 23133 | 15:37:32 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:32 INFO - PROCESS | 23133 | RSS: Main: 158146560 15:37:32 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | Cycle 1(1): loaded http://localhost:49094/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49094/tests/kraken/driver.html?testName=ai-astar) 15:37:34 INFO - PROCESS | 23133 | RSS: Main: 158732288 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | __start_tp_report 15:37:34 INFO - PROCESS | 23133 | _x_x_mozilla_page_load 15:37:34 INFO - PROCESS | 23133 | _x_x_mozilla_page_load_details 15:37:34 INFO - PROCESS | 23133 | |i|pagename|runs| 15:37:34 INFO - PROCESS | 23133 | |0;ai-astar;113;107;112;110;111;110;111;111;110;109 15:37:34 INFO - PROCESS | 23133 | |1;audio-beat-detection;155;128;156;172;127;156;156;135;179;125 15:37:34 INFO - PROCESS | 23133 | |2;audio-dft;163;165;166;163;161;163;162;162;162;160 15:37:34 INFO - PROCESS | 23133 | |3;audio-fft;76;77;76;164;76;75;75;76;159;75 15:37:34 INFO - PROCESS | 23133 | |4;audio-oscillator;85;84;140;85;84;85;146;85;85;148 15:37:34 INFO - PROCESS | 23133 | |5;imaging-gaussian-blur;118;118;117;118;117;117;117;117;118;117 15:37:34 INFO - PROCESS | 23133 | |6;imaging-darkroom;146;147;147;148;147;147;147;147;148;148 15:37:34 INFO - PROCESS | 23133 | |7;imaging-desaturate;96;94;95;95;95;96;95;95;95;95 15:37:34 INFO - PROCESS | 23133 | |8;json-parse-financial;51;57;58;53;53;53;56;52;52;52 15:37:34 INFO - PROCESS | 23133 | |9;json-stringify-tinderbox;59;61;60;61;60;60;60;60;60;61 15:37:34 INFO - PROCESS | 23133 | |10;stanford-crypto-aes;77;76;80;77;78;76;77;78;113;77 15:37:34 INFO - PROCESS | 23133 | |11;stanford-crypto-ccm;122;124;126;117;119;131;119;127;131;128 15:37:34 INFO - PROCESS | 23133 | |12;stanford-crypto-pbkdf2;165;154;158;154;157;154;158;155;154;155 15:37:34 INFO - PROCESS | 23133 | |13;stanford-crypto-sha256-iterative;62;63;62;62;61;63;61;62;62;65 15:37:34 INFO - PROCESS | 23133 | __end_tp_report 15:37:34 INFO - PROCESS | 23133 | __start_cc_report 15:37:34 INFO - PROCESS | 23133 | _x_x_mozilla_cycle_collect,867 15:37:34 INFO - PROCESS | 23133 | __end_cc_report 15:37:34 INFO - PROCESS | 23133 | __startTimestamp1470091054744__endTimestamp 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | ------- Summary: start ------- 15:37:34 INFO - PROCESS | 23133 | Number of tests: 14 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.65 (1.5%) stddev-sans-first:1.45 15:37:34 INFO - PROCESS | 23133 | Values: 113.0 107.0 112.0 110.0 111.0 110.0 111.0 111.0 110.0 109.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:19.17 (12.3%) stddev-sans-first:20.21 15:37:34 INFO - PROCESS | 23133 | Values: 155.0 128.0 156.0 172.0 127.0 156.0 156.0 135.0 179.0 125.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.77 (1.1%) stddev-sans-first:1.87 15:37:34 INFO - PROCESS | 23133 | Values: 163.0 165.0 166.0 163.0 161.0 163.0 162.0 162.0 162.0 160.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:36.18 (47.6%) stddev-sans-first:37.85 15:37:34 INFO - PROCESS | 23133 | Values: 76.0 77.0 76.0 164.0 76.0 75.0 75.0 76.0 159.0 75.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:29.03 (34.2%) stddev-sans-first:30.07 15:37:34 INFO - PROCESS | 23133 | Values: 85.0 84.0 140.0 85.0 84.0 85.0 146.0 85.0 85.0 148.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:37:34 INFO - PROCESS | 23133 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 15:37:34 INFO - PROCESS | 23133 | Values: 146.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 15:37:34 INFO - PROCESS | 23133 | Values: 96.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:2.41 (4.5%) stddev-sans-first:2.35 15:37:34 INFO - PROCESS | 23133 | Values: 51.0 57.0 58.0 53.0 53.0 53.0 56.0 52.0 52.0 52.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 15:37:34 INFO - PROCESS | 23133 | Values: 59.0 61.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 61.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:77.00 stddev:11.34 (14.7%) stddev-sans-first:11.94 15:37:34 INFO - PROCESS | 23133 | Values: 77.0 76.0 80.0 77.0 78.0 76.0 77.0 78.0 113.0 77.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:5.04 (4.0%) stddev-sans-first:5.27 15:37:34 INFO - PROCESS | 23133 | Values: 122.0 124.0 126.0 117.0 119.0 131.0 119.0 127.0 131.0 128.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:156.00 stddev:3.44 (2.2%) stddev-sans-first:1.74 15:37:34 INFO - PROCESS | 23133 | Values: 165.0 154.0 158.0 154.0 157.0 154.0 158.0 155.0 154.0 155.0 15:37:34 INFO - PROCESS | 23133 | 15:37:34 INFO - PROCESS | 23133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 15:37:34 INFO - PROCESS | 23133 | Values: 62.0 63.0 62.0 62.0 61.0 63.0 61.0 62.0 62.0 65.0 15:37:34 INFO - PROCESS | 23133 | -------- Summary: end -------- 15:37:34 INFO - PROCESS | 23133 | 15:37:35 INFO - TEST-INFO | 23133: exit 0 15:37:35 INFO - TEST-OK | kraken | took 60372ms 15:37:35 INFO - SUITE-END | took 1169s 15:37:35 INFO - Completed test suite (00:19:29) 15:37:35 INFO - javascript benchmark 15:37:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.885882345396, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.2878581105065, 3345.6988871001604, 3373.69636732694, 3384.8476818543163, 3388.0174749322705, 5542.674614152233, 5561.527270182034, 5578.665280083198, 5604.831855044345, 5625.915611265824, 5562.638428502155, 5583.748731307091, 5599.8600034999145, 5602.691851948141, 5612.971935140318, 5048.141815891298, 5113.744312784346, 5124.871878203037, 5142.871428214287, 5171.7672704728375, 4980.4272508661425, 5005.849824505271, 5158.535731784139, 5177.430482646924, 5193.870153246161, 4996.650234483587, 5013.548780609744, 5038.5969122470115, 5060.4686507916695, 5062.443131255559, 5043.546080852722, 5096.3884333879805, 5114.232865070232, 5117.769700363493, 5132.999065182291, 4882.292067650171, 4899.28960300758, 5017.573506251973, 5029.220470827027, 5081.822136225214, 5361.437049109865, 5433.239346491494, 5475.589330800206, 5481.808136715235, 5520.66875987442, 5967.731452084667, 6015.398460153993, 6024.879502409927, 6025.276966763972, 6047.637141771508, 5782.2483077199695, 5941.910871336933, 6011.969940150315, 6050.515958723336, 6068.453839154453, 5648.01159797038, 5649.830505084854, 5659.037963546207, 5665.830025099253, 5686.346070201897, 6179.84550386235, 6185.288691800411, 6188.257409110845, 6191.721372538246, 6193.163922870445, 5687.4596913294, 5773.422657734277, 5788.855278618068, 5820.592558520948, 5920.644761314335, 5963.79126730571, 5967.6419414835245, 5973.1338955852025, 5979.312379076375, 5980.641161530322, 5895.233619629506, 5931.228940237827, 5933.910991335047, 5953.76184952597, 5962.19510366095, 5813.157092221604, 5892.970535147382, 5911.970440147772, 5953.910691339634, 5958.195643588147, 4579.977100114478, 4580.1755683976535, 4608.976955115203, 4615.769211539409, 4621.514740952219, 4101.7744024078365, 4110.815013324408, 4132.690048246393, 4134.710570260053, 4162.875113746592, 5656.547476201894, 5726.656400615976, 5777.740001699934, 5862.853428664317, 5890.352061273256, 6062.545309101835, 6080.118382834465, 6083.908741368883, 6085.2393450818645, 6112.541559383064, 5675.120356344773, 5750.137479378043, 5758.539316854642, 5813.709314534256, 5827.737751801179, 5130.948690513047, 5159.922601160985, 5170.97414512925, 5206.062908676399, 5207.895842083213, 6237.781677641261, 6257.655828929362, 6268.247810262797, 6269.592476489013, 6277.246730392382, 6027.0356742921795, 6040.1241819934985, 6052.66710330936, 6054.0, 6061.272647282354, 6080.209572755691, 6195.783147589813, 6264.812055638338, 6280.780172693934, 6383.106365108982, 5997.880042399215, 5998.550108741949, 6009.278886533644, 6024.186734790747, 6024.518038556993, 5847.707614619337, 6077.5745697802495, 6081.5742897996715, 6096.177016102769, 6107.84730381744, 5802.897449484584, 5821.592488525763, 5857.4435428634215, 5887.3523912370465, 5918.940810591839, 5822.883542329215, 5839.445252700986, 5840.328362238397, 5847.970760146172, 5853.970730146322, 5669.433056694297, 5725.770969161187, 5779.537636989115, 5787.8553036174435, 5793.449622285876, 5846.123081537803, 5873.706314684163, 5912.0, 5926.407359264039, 5946.048632218824, 5795.710214489174, 5807.709614519173, 5847.619904706181, 5848.2689663792025, 5863.589548731718], "value": 5537.776969560491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.3291297290548, 633.0535848905885, 639.2233436374804, 655.0861548140344, 657.1325849878161, 37171.814140929295, 45644.0, 46503.0, 46686.76656616716, 49901.25148122781, 47491.28763068548, 47632.28551571729, 48106.0, 48122.315718949845, 48275.75862120693, 8996.91003089969, 9166.312526560501, 9194.770130746718, 9195.988441271455, 9232.399894006901, 9029.23251523618, 9064.954675226614, 9088.954555227248, 9147.085291470832, 9170.266378689723, 9147.54262286883, 9180.0, 9181.908180918206, 9182.724518264462, 9218.86171707425, 9111.271098312152, 9198.0, 9202.263818894473, 9206.355555111146, 9212.216961558275, 9010.59452324647, 9095.81808363829, 9097.909020909772, 9101.863472047924, 9114.954425227832, 44325.0, 44393.77803110996, 44777.32834007493, 44875.0, 44888.0, 3546.219831637036, 3728.9440658390145, 3844.519435070616, 3928.744631598937, 4391.516933137353, 33915.0, 34295.0, 34412.655873441196, 34520.654793452, 34609.653903460894, 4794.37673102498, 4807.471178170398, 4843.612510999112, 4894.877628059291, 4954.851354459372, 339332.0, 342143.0, 342182.0, 343203.0, 343956.0, 33947.83026084854, 34903.82548087294, 65530.0, 65549.6722516394, 65898.67050664716, 38268.0, 38808.80595597004, 38885.666859988494, 38950.610493894696, 38974.61025389766, 14106.788398174036, 14201.218932958787, 14236.715265694627, 14244.715105697827, 14287.85712142886, 10953.780924381468, 10976.615818446317, 11066.944665276622, 11074.667759967213, 11132.944335278435, 9107.180353768194, 9121.863172052424, 9197.264218862474, 9200.815983680423, 9224.215941645036, 3518.5953615334565, 3542.0436482149676, 3605.3149901518627, 3607.5129857469433, 3618.9276214475562, 1054.6150655010865, 1071.9464026798628, 1086.473060565625, 1117.3966058328413, 1207.0464333176692, 31148.0, 32083.839580802414, 32228.516572251436, 32798.01605951777, 32931.67068329334, 1127.8421021057059, 1161.5992482593492, 1174.9823752643717, 1214.1440284599337, 1232.1805999010737, 16920.57698557521, 16962.745558816627, 17041.062741549333, 17235.588150533007, 17318.740218896728, 154984.0, 842030.0, 859673.0, 861685.0, 972489.0, 59656.403435965956, 60102.699486502286, 60484.69757651183, 60568.39431605628, 60634.0, 1425.4298280687808, 1454.6872422429228, 1472.2785834941017, 1480.267267702494, 1487.516557118919, 31619.0, 32607.510887336233, 32782.50826237656, 32896.83551582227, 33308.66691333152, 51894.0, 52190.0, 52471.73764131155, 52558.211626824865, 52559.47440525546, 421413.0, 422945.0, 423009.0, 424077.0, 425305.0, 29890.850545748002, 29993.70006299909, 30120.548191776703, 30308.545371819, 30354.392912142077, 47021.48681150843, 47924.7603761979, 47941.04117917692, 48086.759566201945, 48139.277910830664, 39727.80136099301, 40168.0, 40472.3929141069, 40618.0, 41568.376474352306, 39594.0, 39704.404433932934, 40219.39670904997, 40469.797651011555, 41137.79431102825, 40035.59964400319, 40257.396139058525, 41074.0, 41119.794401029, 41236.79381603073, 35669.82165089158, 36491.0, 37351.43972840464, 37355.439668404455, 37397.065073373386, 28260.576091358234, 28841.71158288474, 28874.566881496376, 28912.0, 29062.0], "value": 19581.539634111694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2589956780819, 402.12337105110845, 403.2358680300829, 410.0855093142293, 412.3073236961904, 16501.0924399158, 18797.248110075598, 20038.699419508717, 20427.591448171046, 20444.386668399955, 12338.753224935519, 12529.0, 12556.434960426779, 18606.418454431358, 18739.43781686548, 5372.865678358043, 5522.0336441122845, 5538.944610553904, 5542.39033706292, 5775.971120144393, 6063.029915213567, 6074.453299203071, 6138.570300078996, 6143.139960405547, 6144.41628045335, 5930.822075337746, 6089.939100608982, 6118.357572454895, 6119.969400152993, 6147.72335244915, 6073.331933487335, 6085.9695701521205, 6092.421219984139, 6121.816345509619, 6129.570930034899, 5773.307203135609, 5978.40215978403, 5983.222181116471, 5994.040953447471, 6038.516918646542, 14306.356213970397, 14618.195999220039, 18101.54746131344, 24070.277891663278, 24260.514789704284, 2353.870537120458, 2370.917017904382, 2390.71311442628, 2448.4980578981267, 2810.325521874756, 10443.95560443957, 10493.737656558571, 10566.735831604194, 10742.194335424874, 10786.137109031259, 2022.0092154844167, 2028.1785876719953, 2031.3093548193538, 2057.584409879593, 2092.529180934293, 79083.60458197672, 79514.0, 79567.80648290222, 80103.79584816658, 84204.57897710534, 10747.0, 11116.944415278034, 11485.942570287261, 11712.765744685059, 11855.881441185651, 16630.66738665244, 16690.66618667644, 16735.414260500824, 16799.748003779954, 16817.57956051084, 7755.457118001686, 8044.195580442026, 8108.0, 8166.877496837552, 8237.83524329522, 7477.252274772588, 7490.176080631126, 7579.848403031909, 7692.46152769312, 7715.267049630276, 4880.389951256093, 5024.748762561857, 5061.620378471629, 5169.53474187325, 5175.0, 2060.721802556666, 2083.7395325584303, 2092.7070210170587, 2105.094809232014, 2108.704781330615, 943.4339396362265, 970.96601618943, 1030.5208078243652, 1065.3022270412891, 1081.0972837680467, 17944.730829037573, 19017.14422850975, 19731.40805775829, 19926.402207933785, 19971.301004465065, 1000.1548691355792, 1016.1413605503337, 1070.662741236508, 1089.4824958144818, 1102.72431892027, 10637.521311540999, 10764.946175269073, 10905.291156074989, 10920.18098642589, 11088.0, 495854.0, 496807.0, 502487.0, 502744.0, 508563.0, 69414.65292673504, 71208.64395678091, 99462.50268748609, 99938.0, 100080.0, 1035.6737627647267, 1050.4275170032352, 1056.1920131099714, 1060.0247772049734, 1063.0538820449806, 17341.73987390165, 17530.91234543819, 17593.472195834147, 17672.823271767116, 17803.55491112681, 39726.0, 41764.582354177284, 42097.0, 42533.57466425296, 43263.56736432595, 57496.42503575078, 60009.69995150171, 60325.69837150786, 60468.69765651144, 60577.69711151416, 7969.163237859942, 8776.956115219384, 8816.867746983671, 9059.094090590888, 9274.814503709753, 13257.403416846073, 13492.257925814174, 13612.65968350799, 13662.0, 13689.931550342184, 9347.766305842408, 10587.629432970118, 12013.339266340086, 12058.216215946286, 12167.330796805907, 11616.361100139573, 11806.881931180922, 11863.0, 12001.15991880595, 12150.635480935585, 11771.646850594496, 12183.0, 12296.508139674313, 12436.316002619942, 12505.874941250471, 8211.83576328482, 8387.245147936716, 8426.705065322683, 8433.409661323649, 8439.789005274917, 11802.52789888395, 12142.150049496451, 12145.210561313486, 12183.573574924834, 12452.750944981231], "value": 9327.313453351675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.113284861205, 1562.4765703489331, 1753.7457068725034, 1868.392772348987, 1892.7350170976065, 8930.55347232639, 9504.097110774483, 9525.571349289272, 9543.61825526979, 9710.70867873965, 9832.164266037378, 9837.0, 9998.10017098461, 9999.250056245774, 10007.049330313608, 2464.8028157747426, 2499.487605040962, 2499.912503062393, 2505.912293069734, 2506.410993416546, 2435.391152211947, 2506.0727530813624, 2509.6737424134835, 2514.346269969812, 2521.306640673811, 2454.3250606083293, 2459.631055341695, 2517.45874636953, 2518.1941778630844, 2519.1938579654516, 2422.1401402502124, 2427.3446169534213, 2434.5982912819454, 2464.8521088734556, 2474.9010039598393, 2355.093289083698, 2384.666146739458, 2388.7611238876148, 2391.629297458897, 2439.560879041772, 9692.563834627388, 9749.220062394992, 9750.658726944594, 9790.5594248259, 9799.16707079899, 5426.67439953604, 5505.256790333294, 5552.111662134039, 5555.749991250363, 5561.388247292794, 3498.0, 3551.3785087609567, 3608.350496910555, 3687.797171155585, 3704.240630670733, 1187.1155988788407, 1201.543413502872, 1206.6561030106377, 1223.5839814463036, 1233.802591585351, 13521.526746563823, 13632.386542605607, 13635.250061246727, 13648.93175534116, 13675.0, 4506.278995360726, 4618.30725391194, 4625.907481850411, 4628.83799067031, 4641.350210970467, 10381.584736610452, 10382.636607718694, 10448.582056717647, 10463.84304235437, 10468.52891619879, 5204.635675502678, 5300.072487314705, 5490.6431081979545, 5511.696856672921, 5522.088855338824, 4830.6135509159185, 4983.8006479741125, 4995.500449955048, 5025.346704928336, 5137.486251374833, 4106.589341065869, 4117.629413352753, 4119.949412899751, 4169.583041695867, 4181.184668989578, 1100.4442756407964, 1117.7485065860117, 1123.9325640461598, 1132.1565433751744, 1176.3471273443322, 909.5634095634133, 1004.4224570871778, 1005.0903931941605, 1005.7988402319565, 1019.9745006374751, 5865.501432378211, 6020.759169633253, 6143.96928015357, 6183.103449999725, 6272.5922815016875, 471.5873610590733, 474.5302150870613, 479.56838845039744, 486.1346802691145, 486.8247430924864, 4438.866833994921, 4466.59800617946, 4562.498125206224, 4627.676062675648, 4636.559526844944, 11719.648410547697, 12160.817587736014, 12243.449044793006, 12278.815817762741, 12332.260064396165, 11824.822627660593, 12210.389480525939, 12231.510739570496, 12256.264624122581, 12257.448414821354, 8815.162559556831, 8835.381523293436, 8855.91144088551, 9045.592948317473, 9125.406848554823, 6444.45222156122, 6542.228793199016, 6580.1116849224745, 6655.134832471747, 6681.997700344987, 11056.557737690402, 11257.662270131581, 11328.263662861887, 11366.147538934778, 11413.372264525531, 11156.330620162817, 11314.264572802742, 11416.086713063101, 11485.885141148481, 11502.079833613123, 7118.9644051779405, 7855.960720196591, 8002.079760827346, 8125.309348705427, 8200.917990820255, 9462.337636365388, 9489.952550237205, 9504.85742713846, 9518.904810952079, 9571.042895710374, 7997.120316765035, 8236.711715089943, 8288.129746376784, 8308.833823323379, 8554.144585541397, 7993.360531157377, 8041.236082572146, 8205.58972051407, 8219.178082191733, 8417.873731893904, 7656.693732250647, 7664.655090520829, 7775.377969762519, 7776.105747838845, 7794.454388192772, 5507.9449205507435, 5518.779248830002, 5611.130274807411, 5698.088305871206, 5703.914441283467, 5493.340799104133, 5584.134459158837, 5622.128570071645, 5692.459216374438, 5701.116326969326], "value": 4858.622832461257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4365576478691, 313.7098184179634, 314.115764123991, 324.4873100501208, 327.8491893728885, 5598.692071936042, 5633.15502674599, 5833.183354330392, 5834.679092649908, 5844.386339434362, 5702.914456283149, 5710.828675139753, 5722.513586345166, 5733.935783118084, 5739.139129130633, 4374.58441448062, 4379.430674012374, 4389.802458889358, 4396.758178300192, 4412.624926881219, 4246.506464347767, 4277.443932288814, 4360.171567402199, 4370.0, 4370.73775573465, 4273.615374616284, 4283.614474697277, 4291.506476755182, 4329.41976178694, 4334.523202447728, 4323.41633879427, 4334.848280310174, 4336.354823557627, 4341.587549182823, 4359.32430473274, 3581.0, 3687.3547129252274, 3690.280395322913, 3691.1325838427947, 3694.2796154749835, 5471.781128754845, 5473.589480788957, 5482.396936337, 5485.341758988947, 5486.862828429281, 4898.779554920037, 4909.533594308571, 4913.606911447076, 4929.088118698017, 4930.753462326869, 5745.368009518949, 5931.317898441691, 5956.55325850563, 5985.730642121115, 6008.399160084, 4083.8774836754947, 4084.5711200323835, 4085.3259212229946, 4088.468499095128, 4093.7923312622847, 5981.9401805981815, 6089.786857460012, 6173.59871608344, 6180.887440260752, 6191.668791209867, 4246.5753424657905, 4262.104957958802, 4265.76538290397, 4269.5516970718245, 4287.7641729705165, 4309.353596960481, 4323.265044942367, 4340.348947657877, 4361.956380436155, 4368.694191406635, 5036.697798132123, 5041.269015992734, 5042.168042273057, 5045.082868509943, 5067.543921047123, 5828.892510423006, 5847.158145184253, 5975.940240597625, 5990.970045149834, 6037.516998640186, 1470.9117452952858, 1485.1237769715704, 1491.2171110167033, 1495.0879963222426, 1500.4148382130977, 903.4534106865383, 920.4569304110607, 923.7413524213231, 927.5223260021095, 930.4742820306506, 5203.557697595671, 5212.609054320941, 5224.634275600672, 5228.398734145546, 5230.0, 5405.78376864921, 5466.972665136649, 5490.588205884575, 5505.916686655406, 5535.754455247617, 5023.497650234947, 5224.216367544898, 5238.60710446718, 5253.553447956967, 5258.395284542326, 2932.4428358611794, 2934.53047512397, 2937.221636266391, 2945.042861070118, 2974.4943359628915, 5649.265595472644, 5662.546996240291, 5673.943260567424, 5684.971575142098, 5709.229254050733, 5245.318108645852, 5526.143447765603, 5529.889402212014, 5531.865967476658, 5554.666719996732, 5630.9019741150905, 5644.6330988485615, 5667.4332566743, 5680.346760122557, 5687.9431205687415, 5276.419593844597, 5350.9732451337495, 5517.2275881377445, 5536.0, 5587.69267690281, 5372.382176049804, 5389.380221274603, 5492.379747974437, 5493.395726470165, 5503.394626591152, 5566.777328906798, 5594.293740409052, 5598.776048957996, 5601.60788744784, 5644.774209031592, 3651.9269614608093, 3877.1470276539117, 3889.2999260133447, 3894.435306880543, 3919.8824035278985, 5383.515483606494, 5488.807891723771, 5510.6969116698965, 6080.4831589313635, 6200.410960958882, 6060.0, 6060.939390606038, 6061.121052473747, 6083.117947897442, 6085.2393450818645, 6065.332813390612, 6070.848228794139, 6078.635281883101, 6122.234720659918, 6158.0, 5703.315602127771, 5966.970165149147, 6027.095935609694, 6046.183765191643, 6050.2437195350585, 6117.0, 6179.455136215946, 6187.535934804998, 6188.44304012641, 6196.566240363131, 5663.8867222656145, 5966.866295403859, 6033.577649564489, 6039.456448919443, 6044.879102418015], "value": 4348.069716223722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.623986126867, 786.9567173805442, 814.4828034198282, 889.5685592487642, 917.7705573606601, 14463.421463141474, 15110.093394396345, 15488.457903973363, 15874.0, 16199.676006479864, 13174.538891138813, 13322.666933326671, 13446.193228406279, 13515.0, 13602.795958060637, 833.6165363932568, 843.4433274039135, 854.8162145138793, 856.8372009318241, 858.1247127929508, 857.8927634045745, 858.3862538285125, 860.1226748716336, 860.3418384935529, 863.4258218284864, 903.4940433357308, 905.5427009360263, 905.959231834569, 909.4316052467208, 910.6812615584525, 899.3434792601372, 901.2744740483907, 901.625825282507, 904.3398319226935, 904.7240591619553, 661.7220767277706, 661.8312330355728, 664.309118516742, 665.1320027364287, 667.5694177255691, 15322.693546129016, 15479.07125572458, 15496.070235785775, 15513.457029004043, 15604.60988475286, 13632.318384080856, 13634.045616806827, 13673.111247768864, 13682.452701891913, 13778.311084445837, 11580.247283926603, 11705.53177872884, 11738.413079346084, 11802.232854864405, 11965.162438629299, 3882.8835134945716, 3886.514185726784, 3917.4319723640197, 3921.215756848642, 3970.0, 82147.58926205331, 82334.0, 82982.58508707478, 83378.0, 83454.0, 10496.737581560523, 10847.02376786093, 10873.83689244662, 11075.390853502973, 11125.332480051224, 18959.810401895804, 19012.0, 19089.331873384366, 19097.904510477638, 19191.424257272025, 8149.877751833727, 8255.339572834158, 8263.710770123016, 8304.958475207586, 8438.409311348147, 4839.249916262915, 4994.225894986283, 5024.070546948826, 5037.19404895215, 5078.873028174251, 3417.5215469834243, 3545.3618348697482, 3554.3957527220437, 3556.270964452281, 3557.3418917500344, 630.3790766095392, 634.3181080338654, 642.6369101457661, 643.7360682120308, 645.6997496164212, 685.4447897203281, 740.5226572986818, 795.3001358804215, 819.5369616166847, 843.2495079379357, 9850.704478865502, 10106.898931010743, 10257.948710256402, 10335.17318614509, 10490.31812932157, 633.6926590603554, 723.4682508356353, 745.2175216023154, 751.7293774241268, 830.887830142923, 4797.0, 4894.535019173173, 4895.4370247422, 4896.216605343128, 4929.186684197139, 68228.65885670639, 110847.44576277067, 116884.41557792157, 117449.0, 118555.0, 86937.0, 95183.52408237914, 99254.00745992592, 100546.4972675132, 102688.48655756674, 87827.56086219529, 88961.55519222491, 89178.0, 90298.54850725704, 91555.54222228847, 9696.175825054666, 9728.923894948523, 9864.556094975887, 9947.751306217402, 9978.800423991624, 42645.36031959461, 44298.55701442944, 47096.29355559738, 50036.49963500319, 51706.48293517167, 75543.0, 75543.0, 76288.61855690686, 77731.22268777466, 78909.0, 12620.936895315464, 12720.109592328448, 12730.299833509245, 12739.426725797546, 12806.61580152597, 13094.214347139203, 13772.31138443094, 13900.721985560434, 14068.718625627225, 14441.7833732492, 13120.60638180856, 13158.342082896008, 13214.0, 13473.393697283449, 13528.458861645424, 12674.049446291381, 13012.349382531025, 13079.738405231652, 13158.802617960548, 13219.339033048116, 12294.446749896455, 12324.753504930031, 12609.117361784587, 13187.67030824237, 13392.196468211549, 10941.945290273497, 10971.122310215003, 11172.345187764238, 11308.830367544659, 11423.0, 11094.167937404889, 11396.886031139582, 11415.771684566096, 11434.542618295174, 11691.590794322157], "value": 7596.72171556156, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 156.0, 172.0, 127.0, 156.0, 156.0, 135.0, 179.0, 125.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 164.0, 76.0, 75.0, 75.0, 76.0, 159.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 140.0, 85.0, 84.0, 85.0, 146.0, 85.0, 85.0, 148.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 57.0, 58.0, 53.0, 53.0, 53.0, 56.0, 52.0, 52.0, 52.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 80.0, 77.0, 78.0, 76.0, 77.0, 78.0, 113.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 126.0, 117.0, 119.0, 131.0, 119.0, 127.0, 131.0, 128.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 154.0, 158.0, 154.0, 157.0, 154.0, 158.0, 155.0, 154.0, 155.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 63.0, 61.0, 62.0, 62.0, 65.0], "value": 62.3, "unit": "score"}]}]} 15:37:35 INFO - Return code: 0 15:37:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:37:36 ERROR - # TBPL SUCCESS # 15:37:36 INFO - Running post-action listener: _resource_record_post_action 15:37:36 INFO - ##### 15:37:36 INFO - ##### Finished run-tests step (success) 15:37:36 INFO - ##### 15:37:36 INFO - Running post-run listener: _resource_record_post_run 15:37:36 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 458289152; Read time: 316; Write time: 325064 15:37:36 INFO - TinderboxPrint: CPU usage
13.4% 15:37:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 316 15:37:36 INFO - TinderboxPrint: I/O write bytes / time
458,289,152 / 325,064 15:37:36 INFO - TinderboxPrint: CPU idle
8,182.3 (86.6%) 15:37:36 INFO - TinderboxPrint: CPU user
1,213.1 (12.8%) 15:37:36 INFO - TinderboxPrint: Swap in / out
0 / 0 15:37:36 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 4096; Write bytes: 235479040; Read time: 172; Write time: 212264 15:37:36 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222806016; Read time: 144; Write time: 112800 15:37:36 INFO - Running post-run listener: _upload_blobber_files 15:37:36 INFO - Blob upload gear active. 15:37:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:36 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 15:37:36 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:37:36 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:37:37 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:37:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:37 INFO - (blobuploader) - INFO - Done attempting. 15:37:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:37:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:37:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:38 INFO - (blobuploader) - INFO - Done attempting. 15:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:42 INFO - (blobuploader) - INFO - Done attempting. 15:37:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:42 INFO - Return code: 0 15:37:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4e14f2bba985028c29fb7a5fb2dcbcf20960430bbef5ee1def13b983e690cd24791ee905d26cf78f15047b77a68023faa76325ac08dcfc1e06ca97bee97bc53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fae3dfa70e8a25b52af9c85f732ecb9149ec08f5335c75ee50cac66774ff6ff2e040fe65517633aa04aea5a46f34d69df689252f2ecc8fbdb3b5b4d670cb11e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43320fbe9f6b6689d70b5effae27c94c3d7aa2023274f0a7914b8bfd1def6ddbf142c8e14d07b3f712261623d693ef131637dca442ecad8b9c4815d62faa332f"} 15:37:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:42 INFO - Contents: 15:37:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4e14f2bba985028c29fb7a5fb2dcbcf20960430bbef5ee1def13b983e690cd24791ee905d26cf78f15047b77a68023faa76325ac08dcfc1e06ca97bee97bc53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fae3dfa70e8a25b52af9c85f732ecb9149ec08f5335c75ee50cac66774ff6ff2e040fe65517633aa04aea5a46f34d69df689252f2ecc8fbdb3b5b4d670cb11e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43320fbe9f6b6689d70b5effae27c94c3d7aa2023274f0a7914b8bfd1def6ddbf142c8e14d07b3f712261623d693ef131637dca442ecad8b9c4815d62faa332f"} 15:37:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:42 INFO - Copying logs to upload dir... 15:37:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.480507 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-01 15:37:41.932722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 15:37:41.936345) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 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/Mozilla-Beta/sha512/b4e14f2bba985028c29fb7a5fb2dcbcf20960430bbef5ee1def13b983e690cd24791ee905d26cf78f15047b77a68023faa76325ac08dcfc1e06ca97bee97bc53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fae3dfa70e8a25b52af9c85f732ecb9149ec08f5335c75ee50cac66774ff6ff2e040fe65517633aa04aea5a46f34d69df689252f2ecc8fbdb3b5b4d670cb11e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43320fbe9f6b6689d70b5effae27c94c3d7aa2023274f0a7914b8bfd1def6ddbf142c8e14d07b3f712261623d693ef131637dca442ecad8b9c4815d62faa332f"} build_url:https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/KOBHRb6GQaWc6WL_UiFKbg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b4e14f2bba985028c29fb7a5fb2dcbcf20960430bbef5ee1def13b983e690cd24791ee905d26cf78f15047b77a68023faa76325ac08dcfc1e06ca97bee97bc53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fae3dfa70e8a25b52af9c85f732ecb9149ec08f5335c75ee50cac66774ff6ff2e040fe65517633aa04aea5a46f34d69df689252f2ecc8fbdb3b5b4d670cb11e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/43320fbe9f6b6689d70b5effae27c94c3d7aa2023274f0a7914b8bfd1def6ddbf142c8e14d07b3f712261623d693ef131637dca442ecad8b9c4815d62faa332f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 15:37:41.961271) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:37:41.961587) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470086757.271965-1020060312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 15:37:42.046792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 15:37:42.047117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 15:37:42.047417) ========= ========= Total master_lag: 0.16 =========