builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1465506675.85 results: success (0) buildid: 20160609095531 builduid: 0f9345d66527428d978b57a8a271bbda revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:15.849268) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:15.849956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:15.850343) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:15.884656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:15.885210) ========= 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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:11:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-06-09 14:11:15 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160686 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.077786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.078111) ========= 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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083606 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.174222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.174608) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --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-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:11:15,978 truncating revision to first 12 chars 2016-06-09 14:11:15,978 Setting DEBUG logging. 2016-06-09 14:11:15,978 attempt 1/10 2016-06-09 14:11:15,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a11eb3fab3c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:11:16,281 unpacking tar archive at: mozilla-aurora-a11eb3fab3c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.849878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.850276) ========= script_repo_revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.850757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.851024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:11:16.861195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 14:11:16.861629) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:11:16 INFO - MultiFileLogger online at 20160609 14:11:16 in /builds/slave/test 14:11:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:11:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:16 INFO - {'append_to_log': False, 14:11:16 INFO - 'base_work_dir': '/builds/slave/test', 14:11:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:11:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:16 INFO - 'branch': 'Mozilla-Aurora', 14:11:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:16 INFO - 'config_files': ('talos/linux_config.py',), 14:11:16 INFO - 'default_actions': ('clobber', 14:11:16 INFO - 'read-buildbot-config', 14:11:16 INFO - 'download-and-extract', 14:11:16 INFO - 'populate-webroot', 14:11:16 INFO - 'create-virtualenv', 14:11:16 INFO - 'install', 14:11:16 INFO - 'run-tests'), 14:11:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:16 INFO - 'download_minidump_stackwalk': True, 14:11:16 INFO - 'download_symbols': 'ondemand', 14:11:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:16 INFO - 'installer_path': 'installer.exe', 14:11:16 INFO - 'log_level': 'info', 14:11:16 INFO - 'log_name': 'talos', 14:11:16 INFO - 'log_to_console': True, 14:11:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:11:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:11:16 INFO - 'opt_config_files': (), 14:11:16 INFO - 'pip_index': False, 14:11:16 INFO - 'sps_profile': False, 14:11:16 INFO - 'sps_profile_interval': 0, 14:11:16 INFO - 'suite': 'dromaeojs-e10s', 14:11:16 INFO - 'system_bits': '32', 14:11:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:16 INFO - 'title': 'talos-linux64-ix-017', 14:11:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:16 INFO - 'use_talos_json': True, 14:11:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:16 INFO - 'work_dir': 'build'} 14:11:16 INFO - ##### 14:11:16 INFO - ##### Running clobber step. 14:11:16 INFO - ##### 14:11:16 INFO - Running pre-action listener: _resource_record_pre_action 14:11:16 INFO - Running main action method: clobber 14:11:16 INFO - rmtree: /builds/slave/test/build 14:11:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:18 INFO - Running post-action listener: _resource_record_post_action 14:11:18 INFO - ##### 14:11:18 INFO - ##### Finished clobber step (success) 14:11:18 INFO - ##### 14:11:18 INFO - ##### 14:11:18 INFO - ##### Running read-buildbot-config step. 14:11:18 INFO - ##### 14:11:18 INFO - Running pre-action listener: _resource_record_pre_action 14:11:18 INFO - Running main action method: read_buildbot_config 14:11:18 INFO - Using buildbot properties: 14:11:18 INFO - { 14:11:18 INFO - "project": "", 14:11:18 INFO - "product": "firefox", 14:11:18 INFO - "script_repo_revision": "production", 14:11:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:11:18 INFO - "repository": "", 14:11:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:11:18 INFO - "buildid": "20160609095531", 14:11:18 INFO - "pgo_build": "True", 14:11:18 INFO - "basedir": "/builds/slave/test", 14:11:18 INFO - "buildnumber": 350, 14:11:18 INFO - "slavename": "talos-linux64-ix-017", 14:11:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:11:18 INFO - "platform": "ubuntu64_hw", 14:11:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:11:18 INFO - "branch": "mozilla-aurora", 14:11:18 INFO - "repo_path": "releases/mozilla-aurora", 14:11:18 INFO - "revision": "a11eb3fab3c603e2b13f8185db8e1815b44d8692", 14:11:18 INFO - "stage_platform": "linux64-pgo", 14:11:18 INFO - "builduid": "0f9345d66527428d978b57a8a271bbda", 14:11:18 INFO - "slavebuilddir": "test" 14:11:18 INFO - } 14:11:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:11:18 INFO - Running post-action listener: _resource_record_post_action 14:11:18 INFO - ##### 14:11:18 INFO - ##### Finished read-buildbot-config step (success) 14:11:18 INFO - ##### 14:11:18 INFO - ##### 14:11:18 INFO - ##### Running download-and-extract step. 14:11:18 INFO - ##### 14:11:18 INFO - Running pre-action listener: _resource_record_pre_action 14:11:18 INFO - Running main action method: download_and_extract 14:11:18 INFO - mkdir: /builds/slave/test/build/tests 14:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:18 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:11:19 INFO - Downloaded 1361 bytes. 14:11:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:11:19 INFO - Using the following test package requirements: 14:11:19 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:11:19 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:11:19 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:11:19 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'jsshell-linux-x86_64.zip'], 14:11:19 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:11:19 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:11:19 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:11:19 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:11:19 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:11:19 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:11:19 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:11:19 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:19 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:20 INFO - Downloaded 24473748 bytes. 14:11:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:11:22 INFO - Return code: 0 14:11:22 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:22 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:11:23 INFO - Downloaded 24473748 bytes. 14:11:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:11:24 INFO - Return code: 0 14:11: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')]} 14:11:24 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:11:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:11:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:11:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:11:25 INFO - Downloaded 10833369 bytes. 14:11:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:11:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:11:25 INFO - Return code: 0 14:11: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')]} 14:11:25 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:11:27 INFO - Downloaded 63559230 bytes. 14:11:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:11:27 INFO - mkdir: /builds/slave/test/properties 14:11:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:27 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:27 INFO - Contents: 14:11:27 INFO - build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:11:28 INFO - Running post-action listener: _resource_record_post_action 14:11:28 INFO - Running post-action listener: set_extra_try_arguments 14:11:28 INFO - ##### 14:11:28 INFO - ##### Finished download-and-extract step (success) 14:11:28 INFO - ##### 14:11:28 INFO - ##### 14:11:28 INFO - ##### Running populate-webroot step. 14:11:28 INFO - ##### 14:11:28 INFO - Running pre-action listener: _resource_record_pre_action 14:11:28 INFO - Running main action method: populate_webroot 14:11:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:28 INFO - '--tppagecycles', 14:11:28 INFO - '7'], 14:11:28 INFO - 'tests': ['tsvgm']}}, 14:11:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['damp', 'tps']}, 14:11:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'tests': ['damp', 'tps']}, 14:11:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['dromaeo_dom']}, 14:11:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['a11yr', 14:11:28 INFO - 'ts_paint', 14:11:28 INFO - 'tpaint', 14:11:28 INFO - 'sessionrestore', 14:11:28 INFO - 'sessionrestore_no_auto_restore', 14:11:28 INFO - 'tabpaint']}, 14:11:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['tsvgx', 14:11:28 INFO - 'tsvgr_opacity', 14:11:28 INFO - 'tart', 14:11:28 INFO - 'tscrollx', 14:11:28 INFO - 'cart']}, 14:11:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:28 INFO - 'tsvgr_opacity', 14:11:28 INFO - 'tart', 14:11:28 INFO - 'tscrollx', 14:11:28 INFO - 'cart']}, 14:11:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'talos_options': ['--disable-e10s'], 14:11:28 INFO - 'tests': ['tp5o']}, 14:11:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'tests': ['tp5o']}, 14:11:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'talos_options': ['--disable-e10s', 14:11:28 INFO - '--xperf_path', 14:11:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:28 INFO - 'tests': ['tp5n']}, 14:11:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:28 INFO - 'talos_options': ['--xperf_path', 14:11:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:28 INFO - 'tests': ['tp5n']}}, 14:11:28 INFO - 'talos.zip': {'path': '', 14:11:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:28 INFO - Running post-action listener: _resource_record_post_action 14:11:28 INFO - ##### 14:11:28 INFO - ##### Finished populate-webroot step (success) 14:11:28 INFO - ##### 14:11:28 INFO - ##### 14:11:28 INFO - ##### Running create-virtualenv step. 14:11:28 INFO - ##### 14:11:28 INFO - Running pre-action listener: _resource_record_pre_action 14:11:28 INFO - Running main action method: create_virtualenv 14:11:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:28 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 14:11:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:28 INFO - Using real prefix '/usr' 14:11:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:35 INFO - Installing pip.................done. 14:11:35 INFO - Return code: 0 14:11:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11: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', 'pip>=1.5'] in /builds/slave/test/build 14:11: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 pip>=1.5 14:11:35 INFO - Using env: {'DISPLAY': ':0', 14:11:35 INFO - 'HOME': '/home/cltbld', 14:11:35 INFO - 'LANG': 'en_US.UTF-8', 14:11:35 INFO - 'LANGUAGE': 'en_US:en', 14:11:35 INFO - 'LOGNAME': 'cltbld', 14:11:35 INFO - 'MAIL': '/var/mail/cltbld', 14:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:35 INFO - 'MOZ_NO_REMOTE': '1', 14:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:35 INFO - 'NO_EM_RESTART': '1', 14:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:35 INFO - 'PWD': '/builds/slave/test', 14:11:35 INFO - 'SHELL': '/bin/bash', 14:11:35 INFO - 'SHLVL': '1', 14:11:35 INFO - 'TERM': 'linux', 14:11:35 INFO - 'TMOUT': '86400', 14:11:35 INFO - 'USER': 'cltbld', 14:11:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:35 INFO - '_': '/tools/buildbot/bin/python'} 14:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:36 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 14:11:36 INFO - Cleaning up... 14:11:36 INFO - Return code: 0 14:11:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:36 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')]} 14:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:36 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')]} 14:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:36 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:36 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 14:11:36 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 14:11:36 INFO - Using env: {'DISPLAY': ':0', 14:11:36 INFO - 'HOME': '/home/cltbld', 14:11:36 INFO - 'LANG': 'en_US.UTF-8', 14:11:36 INFO - 'LANGUAGE': 'en_US:en', 14:11:36 INFO - 'LOGNAME': 'cltbld', 14:11:36 INFO - 'MAIL': '/var/mail/cltbld', 14:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:36 INFO - 'MOZ_NO_REMOTE': '1', 14:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:36 INFO - 'NO_EM_RESTART': '1', 14:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:36 INFO - 'PWD': '/builds/slave/test', 14:11:36 INFO - 'SHELL': '/bin/bash', 14:11:36 INFO - 'SHLVL': '1', 14:11:36 INFO - 'TERM': 'linux', 14:11:36 INFO - 'TMOUT': '86400', 14:11:36 INFO - 'USER': 'cltbld', 14:11:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:36 INFO - '_': '/tools/buildbot/bin/python'} 14:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:36 INFO - Downloading/unpacking psutil>=3.1.1 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:38 INFO - Installing collected packages: psutil 14:11:38 INFO - Running setup.py install for psutil 14:11:38 INFO - building 'psutil._psutil_linux' extension 14:11:38 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 14:11:39 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 14:11:39 INFO - building 'psutil._psutil_posix' extension 14:11:39 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 14:11:39 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 14:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:39 INFO - Successfully installed psutil 14:11:39 INFO - Cleaning up... 14:11:39 INFO - Return code: 0 14:11:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:39 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')]} 14:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 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')]} 14:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:39 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 14:11:39 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 14:11:39 INFO - Using env: {'DISPLAY': ':0', 14:11:39 INFO - 'HOME': '/home/cltbld', 14:11:39 INFO - 'LANG': 'en_US.UTF-8', 14:11:39 INFO - 'LANGUAGE': 'en_US:en', 14:11:39 INFO - 'LOGNAME': 'cltbld', 14:11:39 INFO - 'MAIL': '/var/mail/cltbld', 14:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:39 INFO - 'MOZ_NO_REMOTE': '1', 14:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:39 INFO - 'NO_EM_RESTART': '1', 14:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:39 INFO - 'PWD': '/builds/slave/test', 14:11:39 INFO - 'SHELL': '/bin/bash', 14:11:39 INFO - 'SHLVL': '1', 14:11:39 INFO - 'TERM': 'linux', 14:11:39 INFO - 'TMOUT': '86400', 14:11:39 INFO - 'USER': 'cltbld', 14:11:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:39 INFO - '_': '/tools/buildbot/bin/python'} 14:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:42 INFO - Installing collected packages: mozsystemmonitor 14:11:42 INFO - Running setup.py install for mozsystemmonitor 14:11:42 INFO - Successfully installed mozsystemmonitor 14:11:42 INFO - Cleaning up... 14:11:42 INFO - Return code: 0 14:11:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:42 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 14:11:42 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 14:11:42 INFO - Using env: {'DISPLAY': ':0', 14:11:42 INFO - 'HOME': '/home/cltbld', 14:11:42 INFO - 'LANG': 'en_US.UTF-8', 14:11:42 INFO - 'LANGUAGE': 'en_US:en', 14:11:42 INFO - 'LOGNAME': 'cltbld', 14:11:42 INFO - 'MAIL': '/var/mail/cltbld', 14:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:42 INFO - 'MOZ_NO_REMOTE': '1', 14:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:42 INFO - 'NO_EM_RESTART': '1', 14:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:42 INFO - 'PWD': '/builds/slave/test', 14:11:42 INFO - 'SHELL': '/bin/bash', 14:11:42 INFO - 'SHLVL': '1', 14:11:42 INFO - 'TERM': 'linux', 14:11:42 INFO - 'TMOUT': '86400', 14:11:42 INFO - 'USER': 'cltbld', 14:11:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:42 INFO - '_': '/tools/buildbot/bin/python'} 14:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:42 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 14:11:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:44 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 14:11:44 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 14:11:44 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 14:11:44 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 14:11:44 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 14:11:44 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 14:11:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:44 INFO - warning: no files found matching '*.txt' 14:11:44 INFO - no previously-included directories found matching 'build' 14:11:44 INFO - no previously-included directories found matching 'dist' 14:11:44 INFO - no previously-included directories found matching '.git*' 14:11:44 INFO - Installing collected packages: jsonschema, functools32 14:11:44 INFO - Running setup.py install for functools32 14:11:44 INFO - warning: no files found matching '*.txt' 14:11:44 INFO - no previously-included directories found matching 'build' 14:11:44 INFO - no previously-included directories found matching 'dist' 14:11:44 INFO - no previously-included directories found matching '.git*' 14:11:44 INFO - Successfully installed jsonschema functools32 14:11:44 INFO - Cleaning up... 14:11:44 INFO - Return code: 0 14:11:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:44 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 14:11:44 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 14:11:44 INFO - Using env: {'DISPLAY': ':0', 14:11:44 INFO - 'HOME': '/home/cltbld', 14:11:44 INFO - 'LANG': 'en_US.UTF-8', 14:11:44 INFO - 'LANGUAGE': 'en_US:en', 14:11:44 INFO - 'LOGNAME': 'cltbld', 14:11:44 INFO - 'MAIL': '/var/mail/cltbld', 14:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:44 INFO - 'MOZ_NO_REMOTE': '1', 14:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:44 INFO - 'NO_EM_RESTART': '1', 14:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:44 INFO - 'PWD': '/builds/slave/test', 14:11:44 INFO - 'SHELL': '/bin/bash', 14:11:44 INFO - 'SHLVL': '1', 14:11:44 INFO - 'TERM': 'linux', 14:11:44 INFO - 'TMOUT': '86400', 14:11:44 INFO - 'USER': 'cltbld', 14:11:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:44 INFO - '_': '/tools/buildbot/bin/python'} 14:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:50 INFO - Downloading docopt-0.6.1.tar.gz 14:11:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:50 INFO - Running setup.py install for blobuploader 14:11:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:50 INFO - Running setup.py install for requests 14:11:51 INFO - Running setup.py install for docopt 14:11:51 INFO - Successfully installed blobuploader requests docopt 14:11:51 INFO - Cleaning up... 14:11:51 INFO - Return code: 0 14:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:51 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:51 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 14:11:51 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 14:11:51 INFO - Using env: {'DISPLAY': ':0', 14:11:51 INFO - 'HOME': '/home/cltbld', 14:11:51 INFO - 'LANG': 'en_US.UTF-8', 14:11:51 INFO - 'LANGUAGE': 'en_US:en', 14:11:51 INFO - 'LOGNAME': 'cltbld', 14:11:51 INFO - 'MAIL': '/var/mail/cltbld', 14:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:51 INFO - 'MOZ_NO_REMOTE': '1', 14:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:51 INFO - 'NO_EM_RESTART': '1', 14:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:51 INFO - 'PWD': '/builds/slave/test', 14:11:51 INFO - 'SHELL': '/bin/bash', 14:11:51 INFO - 'SHLVL': '1', 14:11:51 INFO - 'TERM': 'linux', 14:11:51 INFO - 'TMOUT': '86400', 14:11:51 INFO - 'USER': 'cltbld', 14:11:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:51 INFO - '_': '/tools/buildbot/bin/python'} 14:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:51 INFO - Running setup.py (path:/tmp/pip-yYUTYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:51 INFO - Running setup.py (path:/tmp/pip-ZjbBFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:51 INFO - Running setup.py (path:/tmp/pip-jz7Fw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:51 INFO - Running setup.py (path:/tmp/pip-0BpgJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:51 INFO - Running setup.py (path:/tmp/pip-TNOxGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:51 INFO - Running setup.py (path:/tmp/pip-0UMt67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:52 INFO - Running setup.py (path:/tmp/pip-z2pIWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:52 INFO - Running setup.py (path:/tmp/pip-vOw4lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:52 INFO - Running setup.py (path:/tmp/pip-odAFAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:52 INFO - Running setup.py (path:/tmp/pip-f4gex2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:52 INFO - Running setup.py (path:/tmp/pip-9DAQqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:52 INFO - Running setup.py (path:/tmp/pip-KmOPRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:52 INFO - Running setup.py (path:/tmp/pip-XjBTpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:52 INFO - Running setup.py (path:/tmp/pip-AZMqEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:52 INFO - Running setup.py (path:/tmp/pip-PIzrvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:52 INFO - Running setup.py (path:/tmp/pip-qsBysQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:52 INFO - Running setup.py (path:/tmp/pip-NHMSf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:52 INFO - Running setup.py install for manifestparser 14:11:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:52 INFO - Running setup.py install for mozcrash 14:11:53 INFO - Running setup.py install for mozdebug 14:11:53 INFO - Running setup.py install for mozdevice 14:11:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for mozfile 14:11:53 INFO - Running setup.py install for mozhttpd 14:11:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for mozinfo 14:11:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for mozInstall 14:11:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for mozleak 14:11:53 INFO - Running setup.py install for mozlog 14:11:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for moznetwork 14:11:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:53 INFO - Running setup.py install for mozprocess 14:11:54 INFO - Running setup.py install for mozprofile 14:11:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Running setup.py install for mozrunner 14:11:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Running setup.py install for mozscreenshot 14:11:54 INFO - Running setup.py install for moztest 14:11:54 INFO - Running setup.py install for mozversion 14:11:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:54 INFO - Cleaning up... 14:11:54 INFO - Return code: 0 14:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:54 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:54 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 14:11:54 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 14:11:54 INFO - Using env: {'DISPLAY': ':0', 14:11:54 INFO - 'HOME': '/home/cltbld', 14:11:54 INFO - 'LANG': 'en_US.UTF-8', 14:11:54 INFO - 'LANGUAGE': 'en_US:en', 14:11:54 INFO - 'LOGNAME': 'cltbld', 14:11:54 INFO - 'MAIL': '/var/mail/cltbld', 14:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:54 INFO - 'MOZ_NO_REMOTE': '1', 14:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:54 INFO - 'NO_EM_RESTART': '1', 14:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:54 INFO - 'PWD': '/builds/slave/test', 14:11:54 INFO - 'SHELL': '/bin/bash', 14:11:54 INFO - 'SHLVL': '1', 14:11:54 INFO - 'TERM': 'linux', 14:11:54 INFO - 'TMOUT': '86400', 14:11:54 INFO - 'USER': 'cltbld', 14:11:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:54 INFO - '_': '/tools/buildbot/bin/python'} 14:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:54 INFO - Running setup.py (path:/tmp/pip-F6tdhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:54 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)) 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:54 INFO - Running setup.py (path:/tmp/pip-DJcIQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:54 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)) 14:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:54 INFO - Running setup.py (path:/tmp/pip-Yku2lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:55 INFO - Running setup.py (path:/tmp/pip-F4eoD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:55 INFO - Running setup.py (path:/tmp/pip-MjUsy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:55 INFO - Running setup.py (path:/tmp/pip-4AGhtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:55 INFO - Running setup.py (path:/tmp/pip-OYlRpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:55 INFO - Running setup.py (path:/tmp/pip-IN7uqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:55 INFO - Running setup.py (path:/tmp/pip-iGJw3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:55 INFO - Running setup.py (path:/tmp/pip-3S7R19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:55 INFO - Running setup.py (path:/tmp/pip-etwoJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:55 INFO - Running setup.py (path:/tmp/pip-mhK2bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:55 INFO - Running setup.py (path:/tmp/pip-NiCYJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:55 INFO - Running setup.py (path:/tmp/pip-T1LtLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:55 INFO - Running setup.py (path:/tmp/pip-1Dq0gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:55 INFO - Running setup.py (path:/tmp/pip-IA1llM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:55 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)) 14:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:55 INFO - Running setup.py (path:/tmp/pip-EFuHFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 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)) 14:11:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:56 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 14:11:56 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 14:11:56 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 14:11:56 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 14:11:56 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 14:11:56 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 14:11:57 INFO - Downloading blessings-1.6.tar.gz 14:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:58 INFO - Installing collected packages: blessings 14:11:58 INFO - Running setup.py install for blessings 14:11:58 INFO - Successfully installed blessings 14:11:58 INFO - Cleaning up... 14:11:58 INFO - Return code: 0 14:11:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:58 INFO - Reading from file tmpfile_stdout 14:11:58 INFO - Current package versions: 14:11:58 INFO - argparse == 1.2.1 14:11:58 INFO - blessings == 1.6 14:11:58 INFO - blobuploader == 1.2.4 14:11:58 INFO - docopt == 0.6.1 14:11:58 INFO - functools32 == 3.2.3-2 14:11:58 INFO - jsonschema == 2.5.1 14:11:58 INFO - manifestparser == 1.1 14:11:58 INFO - mozInstall == 1.12 14:11:58 INFO - mozcrash == 0.17 14:11:58 INFO - mozdebug == 0.1 14:11:58 INFO - mozdevice == 0.48 14:11:58 INFO - mozfile == 1.2 14:11:58 INFO - mozhttpd == 0.7 14:11:58 INFO - mozinfo == 0.9 14:11:58 INFO - mozleak == 0.1 14:11:58 INFO - mozlog == 3.2 14:11:58 INFO - moznetwork == 0.27 14:11:58 INFO - mozprocess == 0.22 14:11:58 INFO - mozprofile == 0.28 14:11:58 INFO - mozrunner == 6.11 14:11:58 INFO - mozscreenshot == 0.1 14:11:58 INFO - mozsystemmonitor == 0.3 14:11:58 INFO - moztest == 0.7 14:11:58 INFO - mozversion == 1.4 14:11:58 INFO - psutil == 3.1.1 14:11:58 INFO - requests == 1.2.3 14:11:58 INFO - wsgiref == 0.1.2 14:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:58 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 14:11:58 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 14:11:58 INFO - Using env: {'DISPLAY': ':0', 14:11:58 INFO - 'HOME': '/home/cltbld', 14:11:58 INFO - 'LANG': 'en_US.UTF-8', 14:11:58 INFO - 'LANGUAGE': 'en_US:en', 14:11:58 INFO - 'LOGNAME': 'cltbld', 14:11:58 INFO - 'MAIL': '/var/mail/cltbld', 14:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:58 INFO - 'MOZ_NO_REMOTE': '1', 14:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:58 INFO - 'NO_EM_RESTART': '1', 14:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:58 INFO - 'PWD': '/builds/slave/test', 14:11:58 INFO - 'SHELL': '/bin/bash', 14:11:58 INFO - 'SHLVL': '1', 14:11:58 INFO - 'TERM': 'linux', 14:11:58 INFO - 'TMOUT': '86400', 14:11:58 INFO - 'USER': 'cltbld', 14:11:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:58 INFO - '_': '/tools/buildbot/bin/python'} 14:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 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)) 14:11:58 INFO - Cleaning up... 14:11:58 INFO - Return code: 0 14:11:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:58 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 14:11:58 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 14:11:58 INFO - Using env: {'DISPLAY': ':0', 14:11:58 INFO - 'HOME': '/home/cltbld', 14:11:58 INFO - 'LANG': 'en_US.UTF-8', 14:11:58 INFO - 'LANGUAGE': 'en_US:en', 14:11:58 INFO - 'LOGNAME': 'cltbld', 14:11:58 INFO - 'MAIL': '/var/mail/cltbld', 14:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:58 INFO - 'MOZ_NO_REMOTE': '1', 14:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:58 INFO - 'NO_EM_RESTART': '1', 14:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:58 INFO - 'PWD': '/builds/slave/test', 14:11:58 INFO - 'SHELL': '/bin/bash', 14:11:58 INFO - 'SHLVL': '1', 14:11:58 INFO - 'TERM': 'linux', 14:11:58 INFO - 'TMOUT': '86400', 14:11:58 INFO - 'USER': 'cltbld', 14:11:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:58 INFO - '_': '/tools/buildbot/bin/python'} 14:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:58 INFO - Cleaning up... 14:11:58 INFO - Return code: 0 14:11:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:58 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 0x7f3c0e3f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c16350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, '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': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', '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 14:11:58 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 14:11:58 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 14:11:58 INFO - Using env: {'DISPLAY': ':0', 14:11:58 INFO - 'HOME': '/home/cltbld', 14:11:58 INFO - 'LANG': 'en_US.UTF-8', 14:11:58 INFO - 'LANGUAGE': 'en_US:en', 14:11:58 INFO - 'LOGNAME': 'cltbld', 14:11:58 INFO - 'MAIL': '/var/mail/cltbld', 14:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:58 INFO - 'MOZ_NO_REMOTE': '1', 14:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:58 INFO - 'NO_EM_RESTART': '1', 14:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:58 INFO - 'PWD': '/builds/slave/test', 14:11:58 INFO - 'SHELL': '/bin/bash', 14:11:58 INFO - 'SHLVL': '1', 14:11:58 INFO - 'TERM': 'linux', 14:11:58 INFO - 'TMOUT': '86400', 14:11:58 INFO - 'USER': 'cltbld', 14:11:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:58 INFO - '_': '/tools/buildbot/bin/python'} 14:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:59 INFO - Downloading/unpacking flake8 14:11:59 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 14:11:59 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 14:11:59 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 14:11:59 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 14:11:59 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 14:11:59 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 14:12:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:12:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:12:00 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 14:12:00 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 14:12:00 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 14:12:00 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 14:12:00 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 14:12:00 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 14:12:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:12:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:01 INFO - no previously-included directories found matching 'docs/_build' 14:12:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:12:01 INFO - Running setup.py install for pep8 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:01 INFO - no previously-included directories found matching 'docs/_build' 14:12:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:12:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:12:01 INFO - Cleaning up... 14:12:01 INFO - Return code: 0 14:12:01 INFO - Running post-action listener: _resource_record_post_action 14:12:01 INFO - Running post-action listener: _start_resource_monitoring 14:12:01 INFO - Starting resource monitoring. 14:12:01 INFO - ##### 14:12:01 INFO - ##### Finished create-virtualenv step (success) 14:12:01 INFO - ##### 14:12:01 INFO - ##### 14:12:01 INFO - ##### Running install step. 14:12:01 INFO - ##### 14:12:01 INFO - Running pre-action listener: _resource_record_pre_action 14:12:01 INFO - Running main action method: install 14:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:02 INFO - Reading from file tmpfile_stdout 14:12:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:02 INFO - Reading from file tmpfile_stdout 14:12:02 INFO - Output received: 14:12:02 INFO - Usage: mozinstall [options] installer 14:12:02 INFO - Options: 14:12:02 INFO - -h, --help show this help message and exit 14:12:02 INFO - -d DEST, --destination=DEST 14:12:02 INFO - Directory to install application into. [default: 14:12:02 INFO - "/builds/slave/test"] 14:12:02 INFO - --app=APP Application being installed. [default: firefox] 14:12:02 INFO - mkdir: /builds/slave/test/build/application 14:12:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:12:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:12:18 INFO - Reading from file tmpfile_stdout 14:12:18 INFO - Output received: 14:12:18 INFO - /builds/slave/test/build/application/firefox/firefox 14:12:18 INFO - Running post-action listener: _resource_record_post_action 14:12:18 INFO - ##### 14:12:18 INFO - ##### Finished install step (success) 14:12:18 INFO - ##### 14:12:18 INFO - ##### 14:12:18 INFO - ##### Running run-tests step. 14:12:18 INFO - ##### 14:12:18 INFO - Running pre-action listener: _resource_record_pre_action 14:12:18 INFO - Running main action method: run_tests 14:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:18 INFO - Python 2.7.3 14:12:18 INFO - Return code: 0 14:12:18 INFO - grabbing minidump binary from tooltool 14:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:18 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 0x1ca51c0>, '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 0x1ca60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:18 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 14:12:18 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 14:12:18 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 14:12:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:18 INFO - Return code: 0 14:12:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:12:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:12:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:12:19 INFO - Return code: 0 14:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 14:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 14:12:19 INFO - Using env: {'DISPLAY': ':0', 14:12:19 INFO - 'HOME': '/home/cltbld', 14:12:19 INFO - 'LANG': 'en_US.UTF-8', 14:12:19 INFO - 'LANGUAGE': 'en_US:en', 14:12:19 INFO - 'LOGNAME': 'cltbld', 14:12:19 INFO - 'MAIL': '/var/mail/cltbld', 14:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:19 INFO - 'MOZ_NO_REMOTE': '1', 14:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:19 INFO - 'NO_EM_RESTART': '1', 14:12:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:19 INFO - 'PWD': '/builds/slave/test', 14:12:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:19 INFO - 'SHELL': '/bin/bash', 14:12:19 INFO - 'SHLVL': '1', 14:12:19 INFO - 'TERM': 'linux', 14:12:19 INFO - 'TMOUT': '86400', 14:12:19 INFO - 'USER': 'cltbld', 14:12:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586', 14:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:19 INFO - '_': '/tools/buildbot/bin/python'} 14:12:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 14:12:19 INFO - mozversion application_buildid: 20160609095531 14:12:19 INFO - mozversion application_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 14:12:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:12:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:19 INFO - mozversion application_name: Firefox 14:12:19 INFO - mozversion application_remotingname: firefox-dev 14:12:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:12:19 INFO - mozversion application_vendor: Mozilla 14:12:19 INFO - mozversion application_version: 49.0a2 14:12:19 INFO - mozversion platform_buildid: 20160609095531 14:12:19 INFO - mozversion platform_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 14:12:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:12:19 INFO - mozversion platform_version: 49.0a2 14:12:19 INFO - using testdate: 1465506739 14:12:19 INFO - actual date: 1465506739 14:12:19 INFO - starting webserver on 'localhost:52148' 14:12:19 INFO - SUITE-START | Running 2 tests 14:12:19 INFO - TEST-START | dromaeo_css 14:12:19 INFO - operating with platform_type : linux_ 14:12:19 INFO - Initialising browser for dromaeo_css test... 14:12:19 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiqT7xr/profile http://localhost:52148/getInfo.html) 14:12:25 INFO - PROCESS | 3322 | __metrics Screen width/height:1600/1200 14:12:25 INFO - PROCESS | 3322 | colorDepth:24 14:12:25 INFO - PROCESS | 3322 | Browser inner width/height: 1024/697 14:12:25 INFO - PROCESS | 3322 | __metrics 14:12:26 ERROR - PROCESS | 3322 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:12:27 INFO - TEST-INFO | 3322: exit 0 14:12:27 INFO - Browser initialized. 14:12:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:27 INFO - TEST-INFO | started process 3450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiqT7xr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:39 INFO - PROCESS | 3450 | RSS: Main: 156082176 14:12:39 INFO - PROCESS | 3450 | 14:13:28 INFO - PROCESS | 3450 | 1465506808666 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] 14:15:37 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52148/tests/dromaeo/cssquery-ext.html) 14:15:38 INFO - PROCESS | 3450 | RSS: Main: 159592448 14:15:38 INFO - PROCESS | 3450 | 14:18:39 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-ext.html (next: http://localhost:52148/tests/dromaeo/cssquery-jquery.html) 14:18:40 INFO - PROCESS | 3450 | RSS: Main: 158019584 14:18:40 INFO - PROCESS | 3450 | 14:21:42 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52148/tests/dromaeo/cssquery-mootools.html) 14:21:42 INFO - PROCESS | 3450 | RSS: Main: 158199808 14:21:42 INFO - PROCESS | 3450 | 14:24:44 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52148/tests/dromaeo/cssquery-prototype.html) 14:24:45 INFO - PROCESS | 3450 | RSS: Main: 157077504 14:24:45 INFO - PROCESS | 3450 | 14:27:47 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52148/tests/dromaeo/cssquery-yui.html) 14:27:48 INFO - PROCESS | 3450 | RSS: Main: 159215616 14:27:48 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-yui.html (next: http://localhost:52148/tests/dromaeo/cssquery-dojo.html) 14:30:50 INFO - PROCESS | 3450 | RSS: Main: 159526912 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | __start_tp_report 14:30:50 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 14:30:50 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 14:30:50 INFO - PROCESS | 3450 | |i|pagename|runs| 14:30:50 INFO - PROCESS | 3450 | |0;dojo.html;3417.4702921047215;3444.0873168610324;3453.3956557602423;3453.844576994035;3479.7390195735325;5754.309482862057;5765.077587585987;5820.301563812349;5858.589898707092;5885.823425297237;5711.2575365202565;5712.371639119693;5771.365149833515;5772.624779389337;5779.942200577993;5192.974035129819;5200.453952334998;5268.683878967274;5283.233931079991;5294.602904782138;5175.922361164586;5192.766325515361;5237.057329680656;5290.814821481249;5298.284731561228;5210.270562121306;5235.921461178085;5246.029484545352;5268.262443257947;5272.525472707455;5280.049591073605;5305.840824775243;5315.813946511892;5325.334333208349;5331.653442526263;5083.6441449098575;5187.896242075175;5269.499397557226;5284.841454756363;5285.762140703678;5549.334079910396;5635.351934527541;5659.292588426447;5709.0580054290995;5742.2247996520355;6088.512918966472;6099.69501524922;6105.8168254952425;6123.081537769326;6132.325444201134;5969.522438204976;6103.908441373339;6185.16500272462;6187.133801267826;6201.100840378165;5727.799527016535;5824.883502329972;5826.679532625746;5837.445442682938;5854.882902341929;6323.36766323364;6336.778212762531;6341.904871426932;6342.207224096988;6352.809415717536;5891;6001.609895356788;6052.636841789418;6082.300535438481;6084.482818960438;6225.657588832658;6226.315105338409;6244.843878902973;6246.968765156236;6247.96876015617;6103.877922441527;6124.081387791867;6162.599431036968;6188.133661287423;6191.783287584913;5966.134910438049;6042.395760423922;6110.480609148183;6118.7105509427565;6193.783217587363;4664.300354946785;4674.065186962621;4685.0395668887795;4687.835925742583;4711.8350857719815;4206.074663574009;4210.621044106045;4221.78891055446;4224.978875105605;4225.112726327506;5736.913946290809;5866;5900.468957793819;5920.851978700567;6005.6997150142315;6128.900367973304;6186.536009799283;6194.5044396448175;6285.402886725754;6311.968440157862;5803;5999.340072592011;6036.547258955508;6040.09398590215;6073;5264.499872512105;5307.495787900143;5311.787528498894;5318.734063296897;5359.598030147755;6398.360163983564;6415.390537898892;6416.871662566816;6438.163038804925;6458.2895881453005;6078.817635470766;6122.733612273432;6204.534659900616;6211.9068213977735;6229.470495007975;6364.109024736633;6397.232332120176;6469.611823290617;6470.611763294218;6479.935200648122;6112.17485639433;6143.324234334309;6149.877002460015;6174.506039516918;6183.938160618336;6033.095035744674;6104.938950610437;6143.907841382472;6252.437280644764;6257.906131407942;6041.063635136561;6082.847928801639;6093.969530152321;6102.7253773579405;6104.32852386246;6063.575549711654;6090.3605121461605;6106.542009349406;6111.663858487826;6112.72492737819;5759.827205183851;5778.8844223114465;5870.706464676835;5883.411658834254;5918.585699001029;6059.757609695563;6064.181335519825;6096.390360963868;6105.114758359924;6111.358307377662;5974.2233509643465;5977.790777322773;5978.581499295007;5984.58107932458;6005.90991135142 14:30:50 INFO - PROCESS | 3450 | |1;ext.html;597.4801922327575;628.2963081348888;635.0854769132452;654.8428377189474;663.7544108679789;33065.83467082664;36388.45417318743;44012.11975760483;45016.549834501646;45136.3229551557;45981;46636.30045549311;46645.30032049522;46684.53315466845;46714.532854671525;8882.06738292478;9105.590248438835;9117.133872282122;9136.223421009223;9142.085791420872;8888.60001299943;9028.277737780994;9040.231580315682;9058.501782401965;9090.772730681752;9036.548172591378;9039.141281578239;9076.682316118937;9133.543322833864;9154.86267705985;9024.684136055206;9027.684031058914;9028.097190280952;9106.77233069172;9120.771980700469;8912.955435222848;8972.551372431351;9002.414843035182;9012.549372531346;9020.729378118602;42290.577094228975;42353.364699529535;42615;42615.57384426147;42696.35955460671;3510.6840384365273;3613.5663720353464;3662.523871896663;3716.8513259469587;4078.2659121358142;33698.49452258218;33874.6612533874;34242.48636270458;34292.657073429444;34354;4551.613112885409;4699.62403007762;4819.59033482151;4940.135476291671;5016.473270306602;379290;381591;382902;382954;384081.07959460304;62891.685541572915;63858.36141638617;64129;64202.35797641964;64433;64223;64475.35524644787;64790;64908;64939;19356.4193074208;19536.70694939577;19595.706064409045;19654.508637283896;19696.507587310432;14800.555983320517;14855.851441485447;14917.850821491864;14938.850611493746;14979.70040599182;18926.33757818497;19343.16239957202;19351.12919918607;19497.415077547696;19538.413847584594;3460.269865067466;7188.856222875514;7355.5586664800285;7449.312137721807;7514.849703005909;1072.9302595331435;1102.5038732570376;1104.8729396119388;1165.830954511591;1168.7487190254137;31742.682573174436;32359;32391.19022024421;32639.020829375157;32656.83671581627;1160.0719424460399;1161.5295805198907;1190.2560899437851;1190.7082764722697;1199.397307841985;16531.256093475822;16619.3352265908;16688.415905443253;16864.915675421544;17005.46950774436;570851;574670;582623;585240;585545;61044.38955610387;61149;61492.770144596856;61599.38400616026;61706.69146654238;1467.090403949558;1473.1087691946432;1483.8293596236356;1485.1534625263712;1489.5233525272026;32082.679173208904;32453.18867028343;32656;32965.67034329626;33185.50221746724;53160.20259696185;53475.46524534705;53489.19766203432;53593.19610205928;53767.46232537625;521017;528775;530259;530287;531661;30045.399092018473;30148.84925575358;30261.546076808427;30629.23426914345;30671.693283066885;49751;49890.750546247036;50114.498855010985;50451.74774126106;50617.74691126521;43773.562264376946;44096.55903440925;44175.558244417145;44219.77890110529;44343.77828110839;41938.37092443555;42466.57533424626;42823.7858810704;42876.78561607172;42970.35544466773;41995.37006944837;42414.57585424106;42502.78748606237;42705.5729442714;42831.57168428276;36886.07784805401;37056.62943370532;37491.250174996894;37761.62238377581;38729;28893.711062889102;29071.854640726662;29176.854115729286;29228.415431691672;29345.559816603196 14:30:50 INFO - PROCESS | 3450 | |2;jquery.html;406.9959300406997;407.9653229475495;408.25697231039504;411.09558970265425;420.9452771139751;14626;18406.631867362645;19382.12780424881;20175.899120504397;20281.797182028175;19224.71162932557;19536.218551257967;19655.410337689893;19786.208551657954;19825.405237842853;5566.749496272678;5601;5681.744321505542;5734.168545560891;5737.311522617292;5605.915911261334;5701.857453563653;5709.857253568653;5712.71436428179;5718.771249150029;5361.195820626898;5665.291838520185;5691.800786972457;5700.600957932947;5721.656700597957;5459.454054594548;5625.38120806711;5642.802501912434;5654.491095801356;5673.149027645845;5062.594992400599;5064;5069.822556210552;5089.54194122527;5109.642325037249;21940;22428.77571224283;22612.660810087862;22816.315510534543;22872.656910146194;2179.106566307806;2345.976540234593;2438.8658623775686;2439.2194497760725;2633.9332570309057;10222.744431389201;10461.895381046244;10519.316244444086;10553.841692374544;10775.892241077567;1949.4931317857317;2031.3093548193685;2042.9080691368924;2086.155107181594;2115.65091759861;82595.58702206511;83049;84366.57816710878;85372.14627853704;85878.99999999937;11725.648230553097;11738.178327517162;11750.177487575958;11776.587819426279;11791.941040294743;16322.428714994918;16476.340946362012;16545.25546350417;16549.50351489457;16568.66862662764;8749.868751968726;8848.911510884938;8849.823003539894;8895;8932.598033088527;8415.95792021036;8445.366597505212;8509;8548.74353769388;8639.611217495101;4947.851564453073;5001.299818025479;5063.063333283354;5087.389513258358;5107.7446127693465;2062.597793430267;2118.82820109386;2153.806157445806;2154.5564471803928;2159.8920053997235;974.780674348266;1030.2736570717625;1062.442217835627;1078.4931082391263;1105.8562386889653;16693;17908.91045544764;18000;18521;18750.812491874905;999.1207737191226;1016.070295679445;1025.0723095598496;1051.952662130206;1052.5894900988621;10160.745981350377;10467.476626168662;10501.159907207406;10537.420441875616;10558.630447934285;463709;472824;478849;480672;482657;91110;93348;97874;99673;99993.50003250083;1034.3276870034388;1039.4387031003325;1048.648702684594;1065.738893970982;1071.0574694269148;15752.842471575595;16298.103604301878;16334.509964701077;16501.504954851374;16706.331746729993;41695.7915210422;41872.3719144207;42428.36357454579;42457.36313955355;43718.56281437145;57953.130703038645;58966;59739.52378585241;60018.09972850498;60075.39924600698;8226.383021273548;8301.501909885426;8353.916460835557;8435.536045517556;8857.025727169877;9184.448933064037;12612;13182.868171318163;13250.867491324963;13394.196348219139;11338.659840204808;11682.824757628812;11787.233829801036;11982.700432489257;12027.819582706092;11207.60773372928;11560;11819.172657913863;11838.585649502225;11867.813218678064;11688.18182727201;11882.16824822254;11906.523739050688;11982.400879956142;12199.207051541622;7906.723264685708;8299.958500207702;8306.667733290842;8324.958375208085;8895.866562001705;10389.116925061455;10549.89450105489;10711.303765255234;10995;11207.66377008691 14:30:50 INFO - PROCESS | 3450 | |3;mootools.html;1534.1638806850265;1569.4428477890349;1776.9111544422783;1888.5184278009106;1906.1041310584021;8554.95722521388;9383.765405864848;9583.66457173999;10015.499225038746;10054.195664346853;9776.804463910717;9782.608695652183;9848;9859.5563199656;9869.16112130468;2487.502499500098;2492.6136448850457;2523.1547431610343;2526.216872769438;2530.911418100367;2414.0464516515967;2488.676472058639;2503.912363067293;2505.6742623458927;2512.5477414065463;2464.088287333689;2464.3099932019063;2481.751824817513;2482.7765501104896;2484.751524847519;2365.727941286757;2428.101602407103;2435.1355268879556;2439.6706444630013;2479.466914613367;2387.2241521505407;2402.8678422686744;2415.867127307997;2416.912389424766;2431.7203521595065;9510.191633711143;9714.368566043184;9721.854172187423;9733.951330243373;9748;5674.290713660793;5752.8274151775095;5759.452851979056;5761.164631128505;5761.539076873882;3620.3483372993114;3685.3182161300247;3771.811409429545;3822.9808850955847;3842.711796615265;1256.7486502699496;1260.2312589320507;1300.5253082624868;1302.446460254388;1304.8564657887625;13928.303584820718;13996.370163342674;13998;14040.648983775487;14059.929700351535;4964.726940018334;5061.493850614983;5134.7946082156295;5161.535461808456;5189.792408303701;11557.422128893522;11604.76790464186;11606.593769218036;11642.825357619642;11648.708782280512;5671.234383358276;5779.682117483579;5794.449527294901;5813.040848260074;5847.590668653239;4552.089582083597;4925.75371231437;5001.599872010231;5025.145725226647;5327.493888080626;4236.385724069993;4257.808398622069;4304.655627549789;4343.326784348431;4348.826046958086;1309.3453273363318;1310.9541166059141;1314.6581888708813;1317.1043690290694;1332.433715670836;950.2445555783169;963.4749061761357;1097.5280629329466;1106.7011906785124;1125.5497800879714;6474.546781725234;6624.966875165594;6697.296783837724;6706.829503295399;6998.195207551095;971.2812518736084;984.9606015759433;1000.8748906386702;1009.2632378363835;1010.9848352274722;4448.421705178306;4492.663050271242;4500.662450316239;4515.0518391137575;4523.185826551252;11849.881501184878;12129.818052729217;12204.877951220551;12222.022238220921;12235.877641223475;11547.480363383667;12049.759004819854;12082.33547154915;12300.138990270596;12369.752604947851;8527.23254907049;8790;8793.340499462565;8816.559172041372;8818.603162857687;6682.198136223684;6734.6632668367365;6883.139607549057;7038.2961703829205;7060.223375428596;11218.2147249695;11238.26951248199;11330.036946859609;11526.82709759371;11572.884271157182;11261.71845703864;11506.07951363872;11563.364014979257;11592.130590205938;11686.18196726255;8232.917670823215;8297.917020829715;8493.32053435736;8532.189442003;8627.741167764978;9264.21254193374;9493.240540756584;9523.666671666459;9532.95233523828;9533.761655958657;8486.236238738544;8606.870896936425;8652.437591556529;8700.347473939353;8849.115088491357;8224.62989165477;8273.296769774637;8327.583620819056;8353.665853365797;8457.069722330416;7737.961310193413;7839.490433121829;7849.058113026474;7851.84296314082;7854.018247719036;5371.973140134274;5540.113581826889;5589.189567512606;5613.635113717595;5716.971415142898;5422.8373148805595;5592.7762889483965;5607.719614019201;5680.11958146488;5692.829215123553 14:30:50 INFO - PROCESS | 3450 | |4;prototype.html;351.8065064214681;356.14347494276274;356.30342680060477;356.54006331831937;360.2506785885357;5864.912026319604;5900.1739756434135;5908.379620139888;5939.0794426863795;5950.732217050232;5818.272715910512;5826.796062137826;5837.8832423351505;5844.937768251068;5849.883002339961;4452.376667266577;4527.411436513249;4535.682502224846;4536.659750518707;4558.293464512989;4538.523455037223;4587.15137699525;4597.42532183477;4622.1217968586025;4633.513481084488;4549.499555048942;4605.953940460603;4608.861734147981;4611.654125940551;4619.74591397473;4386.640141556112;4519.27691569349;4526.52471490492;4538.183127037132;4551.499335073139;4005.619466150711;4012.558618551957;4015.4177644241713;4026.939595906064;4040.8989775255855;5686.431356864322;5688.345840228344;5709.914351284734;5711.7715291388295;5742.593064699134;5066.707681926672;5222.477752224785;5231.581473482112;5235.816746413895;5247.790088396459;6112.602680825732;6201.937980620181;6211.47202487789;6219.844503887393;6227.906581401283;4283;4478.2610869206865;4491.25894227452;4491.550844915482;4509.751963641998;6151.200343955302;6374.490040796772;6380.585261958005;6388.137601423841;6391.936080639227;4413.44831896013;4427.402300689366;4428.402165707653;4443.466783985942;4469.927217467784;4491.281394976788;4515.2324104902245;4528.320751887243;4532.093581283756;4557.817687292538;4917.598484431991;5135.459362191327;5185.196294574347;5212.921806172911;5231.3199284092825;6098.817035488943;6109.266887973472;6110.594563250388;6143.32423433422;6152.692365381713;1533.4556232537511;1566.6839854522257;1568.4745610220705;1570.6544560196967;1573.2684301799718;951.971870379988;975.6341371985505;986.2553771902168;990.5790039233297;996.1134590214715;5319.9202011969855;5348.866278343073;5362.436944120889;5369.597280203922;5372.247885296062;5463.590230732711;5620.97189514058;5624.3813180550105;5660.716964151776;5692.459216374438;5296.967091417214;5307.548858347007;5600.803971861047;6066.786642671484;6104.511639068864;3393.9151521211675;3401.5918089828883;3413.334399792017;3418.7265018798435;3441.7934923904145;6224.346443623445;6501.902471462932;6599.70301336441;6609.471242300604;6613.570117942415;6503.25212600557;6511.38141876521;6523.64119973406;6555.770548030891;6571.769988050491;6389.169407977026;6648.767293144717;6673.298308931191;6677.732890684319;6682.630060837517;6380.585261957958;6401.487880969605;6422.32565580626;6425.1004859320665;6437.581557198767;5995.220621319375;6252.249730032425;6267.780627678009;6283.5601507895835;6307.463865571478;6432.871342573216;6581.506387020897;6647.60114393138;6655.866882662416;6658.83352916181;4452.1763473757455;4468.352088947149;4471.754053527087;4486.7756612169915;4489.079738653633;6307.590006649553;6356.809295721136;6398.296187419473;6402.487800976004;6437.324080971618;6153.476954458921;6154.230721159855;6159.753609855556;6193.637399772043;6199.969000154971;5912.807084174669;6177.289611694712;6198.597091189058;6199.659018754011;6219.657918814328;5991.7902873399225;6088.634681918922;6097.451229389376;6115.235595550556;6130.846728831815;6197.1718343088;6278.843028924313;6312.43188113072;6325.778597749057;6326.41839540115;5778.219940308173;6089.66027473955;6142.539309551891;6179.721912513858;6213.37866213375 14:30:50 INFO - PROCESS | 3450 | |5;yui.html;709.5813470052668;790.0992868130329;806.1132753970633;840.6427268410926;842.9873551896723;14486.420543178274;14957.850421495781;15456.922715386407;15515;15627;14266.500672476466;14321.71356572868;14329.426822927071;14330.856691433082;14343.067700599453;668.5921587831419;770.8728059870115;845.8054647431064;872.1060912564609;873.3668090634271;775.8448310337927;780.2860382749806;781.5623250979442;783.3811289081618;784.4979213303491;817.7424111404919;818.467995802727;818.54161669465;820.6184124382161;822.0792712162387;849.5709666618349;850.7915560687641;859.6045818923303;866.3026263857593;878.1131057631774;661.0249881424908;661.9503537234726;662.6951602262965;664.6510581944469;664.7872680742164;15114.39542418302;15285;15352.385904563804;15382.461613843461;15400.921935464521;15384.307706153138;15765.290561924627;15908.840911590967;15995.760063599055;16034.118123503202;12550.874491255061;12558.560450384284;12763.106582539225;12785;12803.103782735212;3991.0621004064024;4097.487814023247;4119.732217405889;4130.979345103256;4182.91634167318;78557.60721196415;79518;80133.59933200297;81266;81969.59015204945;11931.761364772656;12277.140600158082;12419.130660853654;12600.4329805159;12761.170523915916;21335.78664213338;21564;21638;21782.128714851227;22114.557708846056;8199.139090395423;8286.627101780314;8366.58167091643;8375.45559538628;8394.790130246793;4623.630109591225;4627.537246275413;4748.4539277982785;4786.114568804782;4789.760511974388;3683.3369993401443;3861.498005259298;3863.7102217333813;3887.319719049155;3895.337792575269;692.7783109405043;732.7288903105884;742.506233354813;742.6806473216461;746.2798399544465;620.4385031546458;654.6628486329544;720.477653701073;729.6169511006764;738.8633102875986;10538.947305263424;10957.232993690524;10982.341059536453;11140.721481963015;11282.323060616225;769.0041396391687;792.2315354106622;807.4267270238079;814.4990830639114;842.9884139033185;5066.316047333637;5097.515736005073;5110.386753589519;5123.872747995435;5205.505476979681;74293.25706742972;74340.25659743442;121150.3942480282;121537.39231303787;121723;111733.44133279282;112130;113450;113728;113936;98143;99818;100188.99999999854;101228.49385753172;101851;9964;10039;10051.095401413908;10113.69658910234;10195.082442580204;54021.45978540164;54057;55148;55464.168037480275;56826.7158664204;75501;80197;80765.19234807577;82552.58723706343;83543;12776.552820651232;12866.549670761478;13179.472821087049;13315.334233288491;13501.582294177768;13654.795178072138;13816.309184540532;13839.930800345934;14217.64455888611;14294.928525357307;13002.219866808022;13340.866591333963;13633.182009079486;13719.725605488034;13734.862651373758;12433.37833108359;13004.024698147867;13049.673758155743;13215.66960825987;13397;12496;12548.749025019632;13033.283169425773;13085.476580936656;13155.144915580457;10558.524866380878;10682.198835087554;10683.465826708478;10991.560337586727;11266.549338026387;10249.641262555775;10580.312279701795;10611.787764244826;10631.255812093388;10667.626633067805 14:30:50 INFO - PROCESS | 3450 | __end_tp_report 14:30:50 INFO - PROCESS | 3450 | __start_cc_report 14:30:50 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,348 14:30:50 INFO - PROCESS | 3450 | __end_cc_report 14:30:50 INFO - PROCESS | 3450 | __startTimestamp1465507850681__endTimestamp 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | ------- Summary: start ------- 14:30:50 INFO - PROCESS | 3450 | Number of tests: 6 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:5745.08 Median:5999.34 stddev:645.19 (10.8%) stddev-sans-first:620.79 14:30:50 INFO - PROCESS | 3450 | Values: 3417.5 3444.1 3453.4 3453.8 3479.7 5754.3 5765.1 5820.3 5858.6 5885.8 5711.3 5712.4 5771.4 5772.6 5779.9 5193.0 5200.5 5268.7 5283.2 5294.6 5175.9 5192.8 5237.1 5290.8 5298.3 5210.3 5235.9 5246.0 5268.3 5272.5 5280.0 5305.8 5315.8 5325.3 5331.7 5083.6 5187.9 5269.5 5284.8 5285.8 5549.3 5635.4 5659.3 5709.1 5742.2 6088.5 6099.7 6105.8 6123.1 6132.3 5969.5 6103.9 6185.2 6187.1 6201.1 5727.8 5824.9 5826.7 5837.4 5854.9 6323.4 6336.8 6341.9 6342.2 6352.8 5891.0 6001.6 6052.6 6082.3 6084.5 6225.7 6226.3 6244.8 6247.0 6248.0 6103.9 6124.1 6162.6 6188.1 6191.8 5966.1 6042.4 6110.5 6118.7 6193.8 4664.3 4674.1 4685.0 4687.8 4711.8 4206.1 4210.6 4221.8 4225.0 4225.1 5736.9 5866.0 5900.5 5920.9 6005.7 6128.9 6186.5 6194.5 6285.4 6312.0 5803.0 5999.3 6036.5 6040.1 6073.0 5264.5 5307.5 5311.8 5318.7 5359.6 6398.4 6415.4 6416.9 6438.2 6458.3 6078.8 6122.7 6204.5 6211.9 6229.5 6364.1 6397.2 6469.6 6470.6 6479.9 6112.2 6143.3 6149.9 6174.5 6183.9 6033.1 6104.9 6143.9 6252.4 6257.9 6041.1 6082.8 6094.0 6102.7 6104.3 6063.6 6090.4 6106.5 6111.7 6112.7 5759.8 5778.9 5870.7 5883.4 5918.6 6059.8 6064.2 6096.4 6105.1 6111.4 5974.2 5977.8 5978.6 5984.6 6005.9 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:65957.83 Median:42854.18 stddev:133882.70 (312.4%) stddev-sans-first:134168.34 14:30:50 INFO - PROCESS | 3450 | Values: 597.5 628.3 635.1 654.8 663.8 33065.8 36388.5 44012.1 45016.5 45136.3 45981.0 46636.3 46645.3 46684.5 46714.5 8882.1 9105.6 9117.1 9136.2 9142.1 8888.6 9028.3 9040.2 9058.5 9090.8 9036.5 9039.1 9076.7 9133.5 9154.9 9024.7 9027.7 9028.1 9106.8 9120.8 8913.0 8972.6 9002.4 9012.5 9020.7 42290.6 42353.4 42615.0 42615.6 42696.4 3510.7 3613.6 3662.5 3716.9 4078.3 33698.5 33874.7 34242.5 34292.7 34354.0 4551.6 4699.6 4819.6 4940.1 5016.5 379290.0 381591.0 382902.0 382954.0 384081.1 62891.7 63858.4 64129.0 64202.4 64433.0 64223.0 64475.4 64790.0 64908.0 64939.0 19356.4 19536.7 19595.7 19654.5 19696.5 14800.6 14855.9 14917.9 14938.9 14979.7 18926.3 19343.2 19351.1 19497.4 19538.4 3460.3 7188.9 7355.6 7449.3 7514.8 1072.9 1102.5 1104.9 1165.8 1168.7 31742.7 32359.0 32391.2 32639.0 32656.8 1160.1 1161.5 1190.3 1190.7 1199.4 16531.3 16619.3 16688.4 16864.9 17005.5 570851.0 574670.0 582623.0 585240.0 585545.0 61044.4 61149.0 61492.8 61599.4 61706.7 1467.1 1473.1 1483.8 1485.2 1489.5 32082.7 32453.2 32656.0 32965.7 33185.5 53160.2 53475.5 53489.2 53593.2 53767.5 521017.0 528775.0 530259.0 530287.0 531661.0 30045.4 30148.8 30261.5 30629.2 30671.7 49751.0 49890.8 50114.5 50451.7 50617.7 43773.6 44096.6 44175.6 44219.8 44343.8 41938.4 42466.6 42823.8 42876.8 42970.4 41995.4 42414.6 42502.8 42705.6 42831.6 36886.1 37056.6 37491.3 37761.6 38729.0 28893.7 29071.9 29176.9 29228.4 29345.6 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:28828.46 Median:22714.49 stddev:78716.34 (346.5%) stddev-sans-first:78908.24 14:30:50 INFO - PROCESS | 3450 | Values: 407.0 408.0 408.3 411.1 420.9 14626.0 18406.6 19382.1 20175.9 20281.8 19224.7 19536.2 19655.4 19786.2 19825.4 5566.7 5601.0 5681.7 5734.2 5737.3 5605.9 5701.9 5709.9 5712.7 5718.8 5361.2 5665.3 5691.8 5700.6 5721.7 5459.5 5625.4 5642.8 5654.5 5673.1 5062.6 5064.0 5069.8 5089.5 5109.6 21940.0 22428.8 22612.7 22816.3 22872.7 2179.1 2346.0 2438.9 2439.2 2633.9 10222.7 10461.9 10519.3 10553.8 10775.9 1949.5 2031.3 2042.9 2086.2 2115.7 82595.6 83049.0 84366.6 85372.1 85879.0 11725.6 11738.2 11750.2 11776.6 11791.9 16322.4 16476.3 16545.3 16549.5 16568.7 8749.9 8848.9 8849.8 8895.0 8932.6 8416.0 8445.4 8509.0 8548.7 8639.6 4947.9 5001.3 5063.1 5087.4 5107.7 2062.6 2118.8 2153.8 2154.6 2159.9 974.8 1030.3 1062.4 1078.5 1105.9 16693.0 17908.9 18000.0 18521.0 18750.8 999.1 1016.1 1025.1 1052.0 1052.6 10160.7 10467.5 10501.2 10537.4 10558.6 463709.0 472824.0 478849.0 480672.0 482657.0 91110.0 93348.0 97874.0 99673.0 99993.5 1034.3 1039.4 1048.6 1065.7 1071.1 15752.8 16298.1 16334.5 16501.5 16706.3 41695.8 41872.4 42428.4 42457.4 43718.6 57953.1 58966.0 59739.5 60018.1 60075.4 8226.4 8301.5 8353.9 8435.5 8857.0 9184.4 12612.0 13182.9 13250.9 13394.2 11338.7 11682.8 11787.2 11982.7 12027.8 11207.6 11560.0 11819.2 11838.6 11867.8 11688.2 11882.2 11906.5 11982.4 12199.2 7906.7 8300.0 8306.7 8325.0 8895.9 10389.1 10549.9 10711.3 10995.0 11207.7 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:6410.79 Median:4507.86 stddev:3715.81 (82.4%) stddev-sans-first:3708.16 14:30:50 INFO - PROCESS | 3450 | Values: 1534.2 1569.4 1776.9 1888.5 1906.1 8555.0 9383.8 9583.7 10015.5 10054.2 9776.8 9782.6 9848.0 9859.6 9869.2 2487.5 2492.6 2523.2 2526.2 2530.9 2414.0 2488.7 2503.9 2505.7 2512.5 2464.1 2464.3 2481.8 2482.8 2484.8 2365.7 2428.1 2435.1 2439.7 2479.5 2387.2 2402.9 2415.9 2416.9 2431.7 9510.2 9714.4 9721.9 9734.0 9748.0 5674.3 5752.8 5759.5 5761.2 5761.5 3620.3 3685.3 3771.8 3823.0 3842.7 1256.7 1260.2 1300.5 1302.4 1304.9 13928.3 13996.4 13998.0 14040.6 14059.9 4964.7 5061.5 5134.8 5161.5 5189.8 11557.4 11604.8 11606.6 11642.8 11648.7 5671.2 5779.7 5794.4 5813.0 5847.6 4552.1 4925.8 5001.6 5025.1 5327.5 4236.4 4257.8 4304.7 4343.3 4348.8 1309.3 1311.0 1314.7 1317.1 1332.4 950.2 963.5 1097.5 1106.7 1125.5 6474.5 6625.0 6697.3 6706.8 6998.2 971.3 985.0 1000.9 1009.3 1011.0 4448.4 4492.7 4500.7 4515.1 4523.2 11849.9 12129.8 12204.9 12222.0 12235.9 11547.5 12049.8 12082.3 12300.1 12369.8 8527.2 8790.0 8793.3 8816.6 8818.6 6682.2 6734.7 6883.1 7038.3 7060.2 11218.2 11238.3 11330.0 11526.8 11572.9 11261.7 11506.1 11563.4 11592.1 11686.2 8232.9 8297.9 8493.3 8532.2 8627.7 9264.2 9493.2 9523.7 9533.0 9533.8 8486.2 8606.9 8652.4 8700.3 8849.1 8224.6 8273.3 8327.6 8353.7 8457.1 7738.0 7839.5 7849.1 7851.8 7854.0 5372.0 5540.1 5589.2 5613.6 5717.0 5422.8 5592.8 5607.7 5680.1 5692.8 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:5154.62 Median:5832.34 stddev:1529.38 (26.2%) stddev-sans-first:1490.58 14:30:50 INFO - PROCESS | 3450 | Values: 351.8 356.1 356.3 356.5 360.3 5864.9 5900.2 5908.4 5939.1 5950.7 5818.3 5826.8 5837.9 5844.9 5849.9 4452.4 4527.4 4535.7 4536.7 4558.3 4538.5 4587.2 4597.4 4622.1 4633.5 4549.5 4606.0 4608.9 4611.7 4619.7 4386.6 4519.3 4526.5 4538.2 4551.5 4005.6 4012.6 4015.4 4026.9 4040.9 5686.4 5688.3 5709.9 5711.8 5742.6 5066.7 5222.5 5231.6 5235.8 5247.8 6112.6 6201.9 6211.5 6219.8 6227.9 4283.0 4478.3 4491.3 4491.6 4509.8 6151.2 6374.5 6380.6 6388.1 6391.9 4413.4 4427.4 4428.4 4443.5 4469.9 4491.3 4515.2 4528.3 4532.1 4557.8 4917.6 5135.5 5185.2 5212.9 5231.3 6098.8 6109.3 6110.6 6143.3 6152.7 1533.5 1566.7 1568.5 1570.7 1573.3 952.0 975.6 986.3 990.6 996.1 5319.9 5348.9 5362.4 5369.6 5372.2 5463.6 5621.0 5624.4 5660.7 5692.5 5297.0 5307.5 5600.8 6066.8 6104.5 3393.9 3401.6 3413.3 3418.7 3441.8 6224.3 6501.9 6599.7 6609.5 6613.6 6503.3 6511.4 6523.6 6555.8 6571.8 6389.2 6648.8 6673.3 6677.7 6682.6 6380.6 6401.5 6422.3 6425.1 6437.6 5995.2 6252.2 6267.8 6283.6 6307.5 6432.9 6581.5 6647.6 6655.9 6658.8 4452.2 4468.4 4471.8 4486.8 4489.1 6307.6 6356.8 6398.3 6402.5 6437.3 6153.5 6154.2 6159.8 6193.6 6200.0 5912.8 6177.3 6198.6 6199.7 6219.7 5991.8 6088.6 6097.5 6115.2 6130.8 6197.2 6278.8 6312.4 6325.8 6326.4 5778.2 6089.7 6142.5 6179.7 6213.4 14:30:50 INFO - PROCESS | 3450 | 14:30:50 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:21698.44 Median:3772.42 stddev:31756.77 (841.8%) stddev-sans-first:31806.75 14:30:50 INFO - PROCESS | 3450 | Values: 709.6 790.1 806.1 840.6 843.0 14486.4 14957.9 15456.9 15515.0 15627.0 14266.5 14321.7 14329.4 14330.9 14343.1 668.6 770.9 845.8 872.1 873.4 775.8 780.3 781.6 783.4 784.5 817.7 818.5 818.5 820.6 822.1 849.6 850.8 859.6 866.3 878.1 661.0 662.0 662.7 664.7 664.8 15114.4 15285.0 15352.4 15382.5 15400.9 15384.3 15765.3 15908.8 15995.8 16034.1 12550.9 12558.6 12763.1 12785.0 12803.1 3991.1 4097.5 4119.7 4131.0 4182.9 78557.6 79518.0 80133.6 81266.0 81969.6 11931.8 12277.1 12419.1 12600.4 12761.2 21335.8 21564.0 21638.0 21782.1 22114.6 8199.1 8286.6 8366.6 8375.5 8394.8 4623.6 4627.5 4748.5 4786.1 4789.8 3683.3 3861.5 3863.7 3887.3 3895.3 692.8 732.7 742.5 742.7 746.3 620.4 654.7 720.5 729.6 738.9 10538.9 10957.2 10982.3 11140.7 11282.3 769.0 792.2 807.4 814.5 843.0 5066.3 5097.5 5110.4 5123.9 5205.5 74293.3 74340.3 121150.4 121537.4 121723.0 111733.4 112130.0 113450.0 113728.0 113936.0 98143.0 99818.0 100189.0 101228.5 101851.0 9964.0 10039.0 10051.1 10113.7 10195.1 54021.5 54057.0 55148.0 55464.2 56826.7 75501.0 80197.0 80765.2 82552.6 83543.0 12776.6 12866.5 13179.5 13315.3 13501.6 13654.8 13816.3 13839.9 14217.6 14294.9 13002.2 13340.9 13633.2 13719.7 13734.9 12433.4 13004.0 13049.7 13215.7 13397.0 12496.0 12548.7 13033.3 13085.5 13155.1 10558.5 10682.2 10683.5 10991.6 11266.5 10249.6 10580.3 10611.8 10631.3 10667.6 14:30:50 INFO - PROCESS | 3450 | -------- Summary: end -------- 14:30:50 INFO - PROCESS | 3450 | 14:30:51 INFO - TEST-INFO | 3450: exit 0 14:30:51 INFO - TEST-OK | dromaeo_css | took 1111588ms 14:30:51 INFO - TEST-START | kraken 14:30:51 INFO - operating with platform_type : linux_ 14:30:51 INFO - Initialising browser for kraken test... 14:30:51 INFO - TEST-INFO | started process 3692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCIzOR/profile http://localhost:52148/getInfo.html) 14:30:55 INFO - PROCESS | 3692 | __metrics Screen width/height:1600/1200 14:30:55 INFO - PROCESS | 3692 | colorDepth:24 14:30:55 INFO - PROCESS | 3692 | Browser inner width/height: 1024/697 14:30:55 INFO - PROCESS | 3692 | __metrics 14:30:56 ERROR - PROCESS | 3692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:30:57 INFO - TEST-INFO | 3692: exit 0 14:30:57 INFO - Browser initialized. 14:30:57 INFO - Running cycle 1/1 for kraken test... 14:30:57 INFO - TEST-INFO | started process 3822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoCIzOR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:09 INFO - PROCESS | 3822 | RSS: Main: 156278784 14:31:09 INFO - PROCESS | 3822 | 14:31:11 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:12 INFO - PROCESS | 3822 | RSS: Main: 161570816 14:31:12 INFO - PROCESS | 3822 | 14:31:15 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-dft) 14:31:15 INFO - PROCESS | 3822 | RSS: Main: 160157696 14:31:15 INFO - PROCESS | 3822 | 14:31:18 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-fft) 14:31:19 INFO - PROCESS | 3822 | RSS: Main: 161300480 14:31:19 INFO - PROCESS | 3822 | 14:31:21 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-oscillator) 14:31:21 INFO - PROCESS | 3822 | RSS: Main: 160993280 14:31:21 INFO - PROCESS | 3822 | 14:31:24 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:24 INFO - PROCESS | 3822 | RSS: Main: 160763904 14:31:24 INFO - PROCESS | 3822 | 14:31:27 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:28 INFO - PROCESS | 3822 | RSS: Main: 161091584 14:31:28 INFO - PROCESS | 3822 | 14:31:31 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:32 INFO - PROCESS | 3822 | RSS: Main: 161964032 14:31:32 INFO - PROCESS | 3822 | 14:31:35 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52148/tests/kraken/driver.html?testName=json-parse-financial) 14:31:35 INFO - PROCESS | 3822 | RSS: Main: 161099776 14:31:35 INFO - PROCESS | 3822 | 14:31:37 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:38 INFO - PROCESS | 3822 | RSS: Main: 160882688 14:31:38 INFO - PROCESS | 3822 | 14:31:39 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:40 INFO - PROCESS | 3822 | RSS: Main: 160575488 14:31:40 INFO - PROCESS | 3822 | 14:31:42 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:43 INFO - PROCESS | 3822 | RSS: Main: 161439744 14:31:43 INFO - PROCESS | 3822 | 14:31:45 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:46 INFO - PROCESS | 3822 | RSS: Main: 161206272 14:31:46 INFO - PROCESS | 3822 | 14:31:49 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:49 INFO - PROCESS | 3822 | RSS: Main: 161026048 14:31:49 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52148/tests/kraken/driver.html?testName=ai-astar) 14:31:51 INFO - PROCESS | 3822 | RSS: Main: 162140160 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | __start_tp_report 14:31:51 INFO - PROCESS | 3822 | _x_x_mozilla_page_load 14:31:51 INFO - PROCESS | 3822 | _x_x_mozilla_page_load_details 14:31:51 INFO - PROCESS | 3822 | |i|pagename|runs| 14:31:51 INFO - PROCESS | 3822 | |0;ai-astar;111;106;111;111;114;110;109;110;111;109 14:31:51 INFO - PROCESS | 3822 | |1;audio-beat-detection;155;125;151;179;130;149;157;125;192;134 14:31:51 INFO - PROCESS | 3822 | |2;audio-dft;162;164;160;162;161;163;163;160;161;165 14:31:51 INFO - PROCESS | 3822 | |3;audio-fft;74;76;75;176;76;75;76;77;167;76 14:31:51 INFO - PROCESS | 3822 | |4;audio-oscillator;85;85;155;84;85;85;146;85;84;132 14:31:51 INFO - PROCESS | 3822 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;118;117;117 14:31:51 INFO - PROCESS | 3822 | |6;imaging-darkroom;146;146;147;149;147;149;146;147;147;146 14:31:51 INFO - PROCESS | 3822 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 14:31:51 INFO - PROCESS | 3822 | |8;json-parse-financial;51;51;51;51;51;51;54;51;52;51 14:31:51 INFO - PROCESS | 3822 | |9;json-stringify-tinderbox;60;60;60;60;60;61;60;61;61;61 14:31:51 INFO - PROCESS | 3822 | |10;stanford-crypto-aes;76;81;78;78;76;78;77;77;105;78 14:31:51 INFO - PROCESS | 3822 | |11;stanford-crypto-ccm;130;118;124;115;125;128;126;136;122;119 14:31:51 INFO - PROCESS | 3822 | |12;stanford-crypto-pbkdf2;161;152;153;155;155;153;151;150;151;150 14:31:51 INFO - PROCESS | 3822 | |13;stanford-crypto-sha256-iterative;62;62;61;62;62;61;63;67;61;61 14:31:51 INFO - PROCESS | 3822 | __end_tp_report 14:31:51 INFO - PROCESS | 3822 | __start_cc_report 14:31:51 INFO - PROCESS | 3822 | _x_x_mozilla_cycle_collect,885 14:31:51 INFO - PROCESS | 3822 | __end_cc_report 14:31:51 INFO - PROCESS | 3822 | __startTimestamp1465507911582__endTimestamp 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | ------- Summary: start ------- 14:31:51 INFO - PROCESS | 3822 | Number of tests: 14 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:2.15 14:31:51 INFO - PROCESS | 3822 | Values: 111.0 106.0 111.0 111.0 114.0 110.0 109.0 110.0 111.0 109.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:153.00 stddev:22.57 (14.8%) stddev-sans-first:23.86 14:31:51 INFO - PROCESS | 3822 | Values: 155.0 125.0 151.0 179.0 130.0 149.0 157.0 125.0 192.0 134.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.66 (1.0%) stddev-sans-first:1.76 14:31:51 INFO - PROCESS | 3822 | Values: 162.0 164.0 160.0 162.0 161.0 163.0 163.0 160.0 161.0 165.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:40.49 (53.3%) stddev-sans-first:42.24 14:31:51 INFO - PROCESS | 3822 | Values: 74.0 76.0 75.0 176.0 76.0 75.0 76.0 77.0 167.0 76.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:85.00 stddev:29.32 (34.5%) stddev-sans-first:30.39 14:31:51 INFO - PROCESS | 3822 | Values: 85.0 85.0 155.0 84.0 85.0 85.0 146.0 85.0 84.0 132.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:31:51 INFO - PROCESS | 3822 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 14:31:51 INFO - PROCESS | 3822 | Values: 146.0 146.0 147.0 149.0 147.0 149.0 146.0 147.0 147.0 146.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:31:51 INFO - PROCESS | 3822 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 14:31:51 INFO - PROCESS | 3822 | Values: 51.0 51.0 51.0 51.0 51.0 51.0 54.0 51.0 52.0 51.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:31:51 INFO - PROCESS | 3822 | Values: 60.0 60.0 60.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:78.00 stddev:8.76 (11.2%) stddev-sans-first:9.14 14:31:51 INFO - PROCESS | 3822 | Values: 76.0 81.0 78.0 78.0 76.0 78.0 77.0 77.0 105.0 78.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.50 stddev:6.20 (4.9%) stddev-sans-first:6.22 14:31:51 INFO - PROCESS | 3822 | Values: 130.0 118.0 124.0 115.0 125.0 128.0 126.0 136.0 122.0 119.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.00 stddev:3.31 (2.2%) stddev-sans-first:1.92 14:31:51 INFO - PROCESS | 3822 | Values: 161.0 152.0 153.0 155.0 155.0 153.0 151.0 150.0 151.0 150.0 14:31:51 INFO - PROCESS | 3822 | 14:31:51 INFO - PROCESS | 3822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.81 (2.9%) stddev-sans-first:1.92 14:31:51 INFO - PROCESS | 3822 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 63.0 67.0 61.0 61.0 14:31:51 INFO - PROCESS | 3822 | -------- Summary: end -------- 14:31:51 INFO - PROCESS | 3822 | 14:31:52 INFO - TEST-INFO | 3822: exit 0 14:31:52 INFO - TEST-OK | kraken | took 61115ms 14:31:52 INFO - SUITE-END | took 1172s 14:31:52 INFO - Completed test suite (00:19:33) 14:31:52 INFO - javascript benchmark 14:31:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7691.527005314444, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3417.4702921047215, 3444.0873168610324, 3453.3956557602423, 3453.844576994035, 3479.7390195735325, 5754.309482862057, 5765.077587585987, 5820.301563812349, 5858.589898707092, 5885.823425297237, 5711.2575365202565, 5712.371639119693, 5771.365149833515, 5772.624779389337, 5779.942200577993, 5192.974035129819, 5200.453952334998, 5268.683878967274, 5283.233931079991, 5294.602904782138, 5175.922361164586, 5192.766325515361, 5237.057329680656, 5290.814821481249, 5298.284731561228, 5210.270562121306, 5235.921461178085, 5246.029484545352, 5268.262443257947, 5272.525472707455, 5280.049591073605, 5305.840824775243, 5315.813946511892, 5325.334333208349, 5331.653442526263, 5083.6441449098575, 5187.896242075175, 5269.499397557226, 5284.841454756363, 5285.762140703678, 5549.334079910396, 5635.351934527541, 5659.292588426447, 5709.0580054290995, 5742.2247996520355, 6088.512918966472, 6099.69501524922, 6105.8168254952425, 6123.081537769326, 6132.325444201134, 5969.522438204976, 6103.908441373339, 6185.16500272462, 6187.133801267826, 6201.100840378165, 5727.799527016535, 5824.883502329972, 5826.679532625746, 5837.445442682938, 5854.882902341929, 6323.36766323364, 6336.778212762531, 6341.904871426932, 6342.207224096988, 6352.809415717536, 5891.0, 6001.609895356788, 6052.636841789418, 6082.300535438481, 6084.482818960438, 6225.657588832658, 6226.315105338409, 6244.843878902973, 6246.968765156236, 6247.96876015617, 6103.877922441527, 6124.081387791867, 6162.599431036968, 6188.133661287423, 6191.783287584913, 5966.134910438049, 6042.395760423922, 6110.480609148183, 6118.7105509427565, 6193.783217587363, 4664.300354946785, 4674.065186962621, 4685.0395668887795, 4687.835925742583, 4711.8350857719815, 4206.074663574009, 4210.621044106045, 4221.78891055446, 4224.978875105605, 4225.112726327506, 5736.913946290809, 5866.0, 5900.468957793819, 5920.851978700567, 6005.6997150142315, 6128.900367973304, 6186.536009799283, 6194.5044396448175, 6285.402886725754, 6311.968440157862, 5803.0, 5999.340072592011, 6036.547258955508, 6040.09398590215, 6073.0, 5264.499872512105, 5307.495787900143, 5311.787528498894, 5318.734063296897, 5359.598030147755, 6398.360163983564, 6415.390537898892, 6416.871662566816, 6438.163038804925, 6458.2895881453005, 6078.817635470766, 6122.733612273432, 6204.534659900616, 6211.9068213977735, 6229.470495007975, 6364.109024736633, 6397.232332120176, 6469.611823290617, 6470.611763294218, 6479.935200648122, 6112.17485639433, 6143.324234334309, 6149.877002460015, 6174.506039516918, 6183.938160618336, 6033.095035744674, 6104.938950610437, 6143.907841382472, 6252.437280644764, 6257.906131407942, 6041.063635136561, 6082.847928801639, 6093.969530152321, 6102.7253773579405, 6104.32852386246, 6063.575549711654, 6090.3605121461605, 6106.542009349406, 6111.663858487826, 6112.72492737819, 5759.827205183851, 5778.8844223114465, 5870.706464676835, 5883.411658834254, 5918.585699001029, 6059.757609695563, 6064.181335519825, 6096.390360963868, 6105.114758359924, 6111.358307377662, 5974.2233509643465, 5977.790777322773, 5978.581499295007, 5984.58107932458, 6005.90991135142], "value": 5702.586398234445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4801922327575, 628.2963081348888, 635.0854769132452, 654.8428377189474, 663.7544108679789, 33065.83467082664, 36388.45417318743, 44012.11975760483, 45016.549834501646, 45136.3229551557, 45981.0, 46636.30045549311, 46645.30032049522, 46684.53315466845, 46714.532854671525, 8882.06738292478, 9105.590248438835, 9117.133872282122, 9136.223421009223, 9142.085791420872, 8888.60001299943, 9028.277737780994, 9040.231580315682, 9058.501782401965, 9090.772730681752, 9036.548172591378, 9039.141281578239, 9076.682316118937, 9133.543322833864, 9154.86267705985, 9024.684136055206, 9027.684031058914, 9028.097190280952, 9106.77233069172, 9120.771980700469, 8912.955435222848, 8972.551372431351, 9002.414843035182, 9012.549372531346, 9020.729378118602, 42290.577094228975, 42353.364699529535, 42615.0, 42615.57384426147, 42696.35955460671, 3510.6840384365273, 3613.5663720353464, 3662.523871896663, 3716.8513259469587, 4078.2659121358142, 33698.49452258218, 33874.6612533874, 34242.48636270458, 34292.657073429444, 34354.0, 4551.613112885409, 4699.62403007762, 4819.59033482151, 4940.135476291671, 5016.473270306602, 379290.0, 381591.0, 382902.0, 382954.0, 384081.07959460304, 62891.685541572915, 63858.36141638617, 64129.0, 64202.35797641964, 64433.0, 64223.0, 64475.35524644787, 64790.0, 64908.0, 64939.0, 19356.4193074208, 19536.70694939577, 19595.706064409045, 19654.508637283896, 19696.507587310432, 14800.555983320517, 14855.851441485447, 14917.850821491864, 14938.850611493746, 14979.70040599182, 18926.33757818497, 19343.16239957202, 19351.12919918607, 19497.415077547696, 19538.413847584594, 3460.269865067466, 7188.856222875514, 7355.5586664800285, 7449.312137721807, 7514.849703005909, 1072.9302595331435, 1102.5038732570376, 1104.8729396119388, 1165.830954511591, 1168.7487190254137, 31742.682573174436, 32359.0, 32391.19022024421, 32639.020829375157, 32656.83671581627, 1160.0719424460399, 1161.5295805198907, 1190.2560899437851, 1190.7082764722697, 1199.397307841985, 16531.256093475822, 16619.3352265908, 16688.415905443253, 16864.915675421544, 17005.46950774436, 570851.0, 574670.0, 582623.0, 585240.0, 585545.0, 61044.38955610387, 61149.0, 61492.770144596856, 61599.38400616026, 61706.69146654238, 1467.090403949558, 1473.1087691946432, 1483.8293596236356, 1485.1534625263712, 1489.5233525272026, 32082.679173208904, 32453.18867028343, 32656.0, 32965.67034329626, 33185.50221746724, 53160.20259696185, 53475.46524534705, 53489.19766203432, 53593.19610205928, 53767.46232537625, 521017.0, 528775.0, 530259.0, 530287.0, 531661.0, 30045.399092018473, 30148.84925575358, 30261.546076808427, 30629.23426914345, 30671.693283066885, 49751.0, 49890.750546247036, 50114.498855010985, 50451.74774126106, 50617.74691126521, 43773.562264376946, 44096.55903440925, 44175.558244417145, 44219.77890110529, 44343.77828110839, 41938.37092443555, 42466.57533424626, 42823.7858810704, 42876.78561607172, 42970.35544466773, 41995.37006944837, 42414.57585424106, 42502.78748606237, 42705.5729442714, 42831.57168428276, 36886.07784805401, 37056.62943370532, 37491.250174996894, 37761.62238377581, 38729.0, 28893.711062889102, 29071.854640726662, 29176.854115729286, 29228.415431691672, 29345.559816603196], "value": 21154.58687040071, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.9959300406997, 407.9653229475495, 408.25697231039504, 411.09558970265425, 420.9452771139751, 14626.0, 18406.631867362645, 19382.12780424881, 20175.899120504397, 20281.797182028175, 19224.71162932557, 19536.218551257967, 19655.410337689893, 19786.208551657954, 19825.405237842853, 5566.749496272678, 5601.0, 5681.744321505542, 5734.168545560891, 5737.311522617292, 5605.915911261334, 5701.857453563653, 5709.857253568653, 5712.71436428179, 5718.771249150029, 5361.195820626898, 5665.291838520185, 5691.800786972457, 5700.600957932947, 5721.656700597957, 5459.454054594548, 5625.38120806711, 5642.802501912434, 5654.491095801356, 5673.149027645845, 5062.594992400599, 5064.0, 5069.822556210552, 5089.54194122527, 5109.642325037249, 21940.0, 22428.77571224283, 22612.660810087862, 22816.315510534543, 22872.656910146194, 2179.106566307806, 2345.976540234593, 2438.8658623775686, 2439.2194497760725, 2633.9332570309057, 10222.744431389201, 10461.895381046244, 10519.316244444086, 10553.841692374544, 10775.892241077567, 1949.4931317857317, 2031.3093548193685, 2042.9080691368924, 2086.155107181594, 2115.65091759861, 82595.58702206511, 83049.0, 84366.57816710878, 85372.14627853704, 85878.99999999937, 11725.648230553097, 11738.178327517162, 11750.177487575958, 11776.587819426279, 11791.941040294743, 16322.428714994918, 16476.340946362012, 16545.25546350417, 16549.50351489457, 16568.66862662764, 8749.868751968726, 8848.911510884938, 8849.823003539894, 8895.0, 8932.598033088527, 8415.95792021036, 8445.366597505212, 8509.0, 8548.74353769388, 8639.611217495101, 4947.851564453073, 5001.299818025479, 5063.063333283354, 5087.389513258358, 5107.7446127693465, 2062.597793430267, 2118.82820109386, 2153.806157445806, 2154.5564471803928, 2159.8920053997235, 974.780674348266, 1030.2736570717625, 1062.442217835627, 1078.4931082391263, 1105.8562386889653, 16693.0, 17908.91045544764, 18000.0, 18521.0, 18750.812491874905, 999.1207737191226, 1016.070295679445, 1025.0723095598496, 1051.952662130206, 1052.5894900988621, 10160.745981350377, 10467.476626168662, 10501.159907207406, 10537.420441875616, 10558.630447934285, 463709.0, 472824.0, 478849.0, 480672.0, 482657.0, 91110.0, 93348.0, 97874.0, 99673.0, 99993.50003250083, 1034.3276870034388, 1039.4387031003325, 1048.648702684594, 1065.738893970982, 1071.0574694269148, 15752.842471575595, 16298.103604301878, 16334.509964701077, 16501.504954851374, 16706.331746729993, 41695.7915210422, 41872.3719144207, 42428.36357454579, 42457.36313955355, 43718.56281437145, 57953.130703038645, 58966.0, 59739.52378585241, 60018.09972850498, 60075.39924600698, 8226.383021273548, 8301.501909885426, 8353.916460835557, 8435.536045517556, 8857.025727169877, 9184.448933064037, 12612.0, 13182.868171318163, 13250.867491324963, 13394.196348219139, 11338.659840204808, 11682.824757628812, 11787.233829801036, 11982.700432489257, 12027.819582706092, 11207.60773372928, 11560.0, 11819.172657913863, 11838.585649502225, 11867.813218678064, 11688.18182727201, 11882.16824822254, 11906.523739050688, 11982.400879956142, 12199.207051541622, 7906.723264685708, 8299.958500207702, 8306.667733290842, 8324.958375208085, 8895.866562001705, 10389.116925061455, 10549.89450105489, 10711.303765255234, 10995.0, 11207.66377008691], "value": 9301.513008242795, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.1638806850265, 1569.4428477890349, 1776.9111544422783, 1888.5184278009106, 1906.1041310584021, 8554.95722521388, 9383.765405864848, 9583.66457173999, 10015.499225038746, 10054.195664346853, 9776.804463910717, 9782.608695652183, 9848.0, 9859.5563199656, 9869.16112130468, 2487.502499500098, 2492.6136448850457, 2523.1547431610343, 2526.216872769438, 2530.911418100367, 2414.0464516515967, 2488.676472058639, 2503.912363067293, 2505.6742623458927, 2512.5477414065463, 2464.088287333689, 2464.3099932019063, 2481.751824817513, 2482.7765501104896, 2484.751524847519, 2365.727941286757, 2428.101602407103, 2435.1355268879556, 2439.6706444630013, 2479.466914613367, 2387.2241521505407, 2402.8678422686744, 2415.867127307997, 2416.912389424766, 2431.7203521595065, 9510.191633711143, 9714.368566043184, 9721.854172187423, 9733.951330243373, 9748.0, 5674.290713660793, 5752.8274151775095, 5759.452851979056, 5761.164631128505, 5761.539076873882, 3620.3483372993114, 3685.3182161300247, 3771.811409429545, 3822.9808850955847, 3842.711796615265, 1256.7486502699496, 1260.2312589320507, 1300.5253082624868, 1302.446460254388, 1304.8564657887625, 13928.303584820718, 13996.370163342674, 13998.0, 14040.648983775487, 14059.929700351535, 4964.726940018334, 5061.493850614983, 5134.7946082156295, 5161.535461808456, 5189.792408303701, 11557.422128893522, 11604.76790464186, 11606.593769218036, 11642.825357619642, 11648.708782280512, 5671.234383358276, 5779.682117483579, 5794.449527294901, 5813.040848260074, 5847.590668653239, 4552.089582083597, 4925.75371231437, 5001.599872010231, 5025.145725226647, 5327.493888080626, 4236.385724069993, 4257.808398622069, 4304.655627549789, 4343.326784348431, 4348.826046958086, 1309.3453273363318, 1310.9541166059141, 1314.6581888708813, 1317.1043690290694, 1332.433715670836, 950.2445555783169, 963.4749061761357, 1097.5280629329466, 1106.7011906785124, 1125.5497800879714, 6474.546781725234, 6624.966875165594, 6697.296783837724, 6706.829503295399, 6998.195207551095, 971.2812518736084, 984.9606015759433, 1000.8748906386702, 1009.2632378363835, 1010.9848352274722, 4448.421705178306, 4492.663050271242, 4500.662450316239, 4515.0518391137575, 4523.185826551252, 11849.881501184878, 12129.818052729217, 12204.877951220551, 12222.022238220921, 12235.877641223475, 11547.480363383667, 12049.759004819854, 12082.33547154915, 12300.138990270596, 12369.752604947851, 8527.23254907049, 8790.0, 8793.340499462565, 8816.559172041372, 8818.603162857687, 6682.198136223684, 6734.6632668367365, 6883.139607549057, 7038.2961703829205, 7060.223375428596, 11218.2147249695, 11238.26951248199, 11330.036946859609, 11526.82709759371, 11572.884271157182, 11261.71845703864, 11506.07951363872, 11563.364014979257, 11592.130590205938, 11686.18196726255, 8232.917670823215, 8297.917020829715, 8493.32053435736, 8532.189442003, 8627.741167764978, 9264.21254193374, 9493.240540756584, 9523.666671666459, 9532.95233523828, 9533.761655958657, 8486.236238738544, 8606.870896936425, 8652.437591556529, 8700.347473939353, 8849.115088491357, 8224.62989165477, 8273.296769774637, 8327.583620819056, 8353.665853365797, 8457.069722330416, 7737.961310193413, 7839.490433121829, 7849.058113026474, 7851.84296314082, 7854.018247719036, 5371.973140134274, 5540.113581826889, 5589.189567512606, 5613.635113717595, 5716.971415142898, 5422.8373148805595, 5592.7762889483965, 5607.719614019201, 5680.11958146488, 5692.829215123553], "value": 5087.437262382572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8065064214681, 356.14347494276274, 356.30342680060477, 356.54006331831937, 360.2506785885357, 5864.912026319604, 5900.1739756434135, 5908.379620139888, 5939.0794426863795, 5950.732217050232, 5818.272715910512, 5826.796062137826, 5837.8832423351505, 5844.937768251068, 5849.883002339961, 4452.376667266577, 4527.411436513249, 4535.682502224846, 4536.659750518707, 4558.293464512989, 4538.523455037223, 4587.15137699525, 4597.42532183477, 4622.1217968586025, 4633.513481084488, 4549.499555048942, 4605.953940460603, 4608.861734147981, 4611.654125940551, 4619.74591397473, 4386.640141556112, 4519.27691569349, 4526.52471490492, 4538.183127037132, 4551.499335073139, 4005.619466150711, 4012.558618551957, 4015.4177644241713, 4026.939595906064, 4040.8989775255855, 5686.431356864322, 5688.345840228344, 5709.914351284734, 5711.7715291388295, 5742.593064699134, 5066.707681926672, 5222.477752224785, 5231.581473482112, 5235.816746413895, 5247.790088396459, 6112.602680825732, 6201.937980620181, 6211.47202487789, 6219.844503887393, 6227.906581401283, 4283.0, 4478.2610869206865, 4491.25894227452, 4491.550844915482, 4509.751963641998, 6151.200343955302, 6374.490040796772, 6380.585261958005, 6388.137601423841, 6391.936080639227, 4413.44831896013, 4427.402300689366, 4428.402165707653, 4443.466783985942, 4469.927217467784, 4491.281394976788, 4515.2324104902245, 4528.320751887243, 4532.093581283756, 4557.817687292538, 4917.598484431991, 5135.459362191327, 5185.196294574347, 5212.921806172911, 5231.3199284092825, 6098.817035488943, 6109.266887973472, 6110.594563250388, 6143.32423433422, 6152.692365381713, 1533.4556232537511, 1566.6839854522257, 1568.4745610220705, 1570.6544560196967, 1573.2684301799718, 951.971870379988, 975.6341371985505, 986.2553771902168, 990.5790039233297, 996.1134590214715, 5319.9202011969855, 5348.866278343073, 5362.436944120889, 5369.597280203922, 5372.247885296062, 5463.590230732711, 5620.97189514058, 5624.3813180550105, 5660.716964151776, 5692.459216374438, 5296.967091417214, 5307.548858347007, 5600.803971861047, 6066.786642671484, 6104.511639068864, 3393.9151521211675, 3401.5918089828883, 3413.334399792017, 3418.7265018798435, 3441.7934923904145, 6224.346443623445, 6501.902471462932, 6599.70301336441, 6609.471242300604, 6613.570117942415, 6503.25212600557, 6511.38141876521, 6523.64119973406, 6555.770548030891, 6571.769988050491, 6389.169407977026, 6648.767293144717, 6673.298308931191, 6677.732890684319, 6682.630060837517, 6380.585261957958, 6401.487880969605, 6422.32565580626, 6425.1004859320665, 6437.581557198767, 5995.220621319375, 6252.249730032425, 6267.780627678009, 6283.5601507895835, 6307.463865571478, 6432.871342573216, 6581.506387020897, 6647.60114393138, 6655.866882662416, 6658.83352916181, 4452.1763473757455, 4468.352088947149, 4471.754053527087, 4486.7756612169915, 4489.079738653633, 6307.590006649553, 6356.809295721136, 6398.296187419473, 6402.487800976004, 6437.324080971618, 6153.476954458921, 6154.230721159855, 6159.753609855556, 6193.637399772043, 6199.969000154971, 5912.807084174669, 6177.289611694712, 6198.597091189058, 6199.659018754011, 6219.657918814328, 5991.7902873399225, 6088.634681918922, 6097.451229389376, 6115.235595550556, 6130.846728831815, 6197.1718343088, 6278.843028924313, 6312.43188113072, 6325.778597749057, 6326.41839540115, 5778.219940308173, 6089.66027473955, 6142.539309551891, 6179.721912513858, 6213.37866213375], "value": 4660.875479250616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.5813470052668, 790.0992868130329, 806.1132753970633, 840.6427268410926, 842.9873551896723, 14486.420543178274, 14957.850421495781, 15456.922715386407, 15515.0, 15627.0, 14266.500672476466, 14321.71356572868, 14329.426822927071, 14330.856691433082, 14343.067700599453, 668.5921587831419, 770.8728059870115, 845.8054647431064, 872.1060912564609, 873.3668090634271, 775.8448310337927, 780.2860382749806, 781.5623250979442, 783.3811289081618, 784.4979213303491, 817.7424111404919, 818.467995802727, 818.54161669465, 820.6184124382161, 822.0792712162387, 849.5709666618349, 850.7915560687641, 859.6045818923303, 866.3026263857593, 878.1131057631774, 661.0249881424908, 661.9503537234726, 662.6951602262965, 664.6510581944469, 664.7872680742164, 15114.39542418302, 15285.0, 15352.385904563804, 15382.461613843461, 15400.921935464521, 15384.307706153138, 15765.290561924627, 15908.840911590967, 15995.760063599055, 16034.118123503202, 12550.874491255061, 12558.560450384284, 12763.106582539225, 12785.0, 12803.103782735212, 3991.0621004064024, 4097.487814023247, 4119.732217405889, 4130.979345103256, 4182.91634167318, 78557.60721196415, 79518.0, 80133.59933200297, 81266.0, 81969.59015204945, 11931.761364772656, 12277.140600158082, 12419.130660853654, 12600.4329805159, 12761.170523915916, 21335.78664213338, 21564.0, 21638.0, 21782.128714851227, 22114.557708846056, 8199.139090395423, 8286.627101780314, 8366.58167091643, 8375.45559538628, 8394.790130246793, 4623.630109591225, 4627.537246275413, 4748.4539277982785, 4786.114568804782, 4789.760511974388, 3683.3369993401443, 3861.498005259298, 3863.7102217333813, 3887.319719049155, 3895.337792575269, 692.7783109405043, 732.7288903105884, 742.506233354813, 742.6806473216461, 746.2798399544465, 620.4385031546458, 654.6628486329544, 720.477653701073, 729.6169511006764, 738.8633102875986, 10538.947305263424, 10957.232993690524, 10982.341059536453, 11140.721481963015, 11282.323060616225, 769.0041396391687, 792.2315354106622, 807.4267270238079, 814.4990830639114, 842.9884139033185, 5066.316047333637, 5097.515736005073, 5110.386753589519, 5123.872747995435, 5205.505476979681, 74293.25706742972, 74340.25659743442, 121150.3942480282, 121537.39231303787, 121723.0, 111733.44133279282, 112130.0, 113450.0, 113728.0, 113936.0, 98143.0, 99818.0, 100188.99999999854, 101228.49385753172, 101851.0, 9964.0, 10039.0, 10051.095401413908, 10113.69658910234, 10195.082442580204, 54021.45978540164, 54057.0, 55148.0, 55464.168037480275, 56826.7158664204, 75501.0, 80197.0, 80765.19234807577, 82552.58723706343, 83543.0, 12776.552820651232, 12866.549670761478, 13179.472821087049, 13315.334233288491, 13501.582294177768, 13654.795178072138, 13816.309184540532, 13839.930800345934, 14217.64455888611, 14294.928525357307, 13002.219866808022, 13340.866591333963, 13633.182009079486, 13719.725605488034, 13734.862651373758, 12433.37833108359, 13004.024698147867, 13049.673758155743, 13215.66960825987, 13397.0, 12496.0, 12548.749025019632, 13033.283169425773, 13085.476580936656, 13155.144915580457, 10558.524866380878, 10682.198835087554, 10683.465826708478, 10991.560337586727, 11266.549338026387, 10249.641262555775, 10580.312279701795, 10611.787764244826, 10631.255812093388, 10667.626633067805], "value": 7781.080085012321, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 114.0, 110.0, 109.0, 110.0, 111.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 151.0, 179.0, 130.0, 149.0, 157.0, 125.0, 192.0, 134.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 162.0, 161.0, 163.0, 163.0, 160.0, 161.0, 165.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 176.0, 76.0, 75.0, 76.0, 77.0, 167.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 155.0, 84.0, 85.0, 85.0, 146.0, 85.0, 84.0, 132.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 149.0, 147.0, 149.0, 146.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.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, 51.0, 51.0, 51.0, 51.0, 51.0, 54.0, 51.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 78.0, 78.0, 76.0, 78.0, 77.0, 77.0, 105.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 118.0, 124.0, 115.0, 125.0, 128.0, 126.0, 136.0, 122.0, 119.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 152.0, 153.0, 155.0, 155.0, 153.0, 151.0, 150.0, 151.0, 150.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 63.0, 67.0, 61.0, 61.0], "value": 62.2, "unit": "score"}]}]} 14:31:52 INFO - Return code: 0 14:31:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:52 ERROR - # TBPL SUCCESS # 14:31:52 INFO - Running post-action listener: _resource_record_post_action 14:31:52 INFO - ##### 14:31:52 INFO - ##### Finished run-tests step (success) 14:31:52 INFO - ##### 14:31:52 INFO - Running post-run listener: _resource_record_post_run 14:31:52 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8093696; Write bytes: 382402560; Read time: 2308; Write time: 433716 14:31:52 INFO - TinderboxPrint: CPU usage
13.4% 14:31:52 INFO - TinderboxPrint: I/O read bytes / time
8,093,696 / 2,308 14:31:52 INFO - TinderboxPrint: I/O write bytes / time
382,402,560 / 433,716 14:31:52 INFO - TinderboxPrint: CPU idle
8,223.6 (86.6%) 14:31:52 INFO - TinderboxPrint: CPU user
1,211.2 (12.8%) 14:31:52 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5283840; Read time: 0; Write time: 416 14:31:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 6332416; Write bytes: 362319872; Read time: 2264; Write time: 427452 14:31:53 INFO - Running post-run listener: _upload_blobber_files 14:31:53 INFO - Blob upload gear active. 14:31:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:53 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 14:31:53 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:53 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:31:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:54 INFO - (blobuploader) - INFO - Done attempting. 14:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:55 INFO - (blobuploader) - INFO - Done attempting. 14:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:59 INFO - (blobuploader) - INFO - Done attempting. 14:31:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:59 INFO - Return code: 0 14:31:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb5606c1562eadb6350de40526d96c013e235f4b0359218c3f9c0d5e68c26f581e22fc6144b96611e3d7eeb81e88052420658c7aebe78316733dd569ad81f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb44eabf9091774dc53a6b09467206227a9d9c542e8f4e8c61773e2b9d39ec47ad31b681e0d254511580d9d89c331f85967fc31b0b32e3057f1861519b7aa0c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc740587c7aa1a4824bf5b732a89e4df5ca58c9bfb90038a17beb54d90b60009f76ae7a1ad3c7c359804d9798be5c5c4fbb561f44a914774fdb5d7523742faf"} 14:31:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:59 INFO - Contents: 14:31:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb5606c1562eadb6350de40526d96c013e235f4b0359218c3f9c0d5e68c26f581e22fc6144b96611e3d7eeb81e88052420658c7aebe78316733dd569ad81f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb44eabf9091774dc53a6b09467206227a9d9c542e8f4e8c61773e2b9d39ec47ad31b681e0d254511580d9d89c331f85967fc31b0b32e3057f1861519b7aa0c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc740587c7aa1a4824bf5b732a89e4df5ca58c9bfb90038a17beb54d90b60009f76ae7a1ad3c7c359804d9798be5c5c4fbb561f44a914774fdb5d7523742faf"} 14:31:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:59 INFO - Copying logs to upload dir... 14:31:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.290666 ========= master_lag: -0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 14:31:59.863795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:59.867128) ========= 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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 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-Aurora/sha512/e7bb5606c1562eadb6350de40526d96c013e235f4b0359218c3f9c0d5e68c26f581e22fc6144b96611e3d7eeb81e88052420658c7aebe78316733dd569ad81f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb44eabf9091774dc53a6b09467206227a9d9c542e8f4e8c61773e2b9d39ec47ad31b681e0d254511580d9d89c331f85967fc31b0b32e3057f1861519b7aa0c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc740587c7aa1a4824bf5b732a89e4df5ca58c9bfb90038a17beb54d90b60009f76ae7a1ad3c7c359804d9798be5c5c4fbb561f44a914774fdb5d7523742faf"} build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7bb5606c1562eadb6350de40526d96c013e235f4b0359218c3f9c0d5e68c26f581e22fc6144b96611e3d7eeb81e88052420658c7aebe78316733dd569ad81f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb44eabf9091774dc53a6b09467206227a9d9c542e8f4e8c61773e2b9d39ec47ad31b681e0d254511580d9d89c331f85967fc31b0b32e3057f1861519b7aa0c2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc740587c7aa1a4824bf5b732a89e4df5ca58c9bfb90038a17beb54d90b60009f76ae7a1ad3c7c359804d9798be5c5c4fbb561f44a914774fdb5d7523742faf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:59.894538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:59.894966) ========= 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=0333a256a5e4f052382dd180000001b1-1465506674.432722-1371953586 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:59.991193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:31:59.991594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:31:59.997423) ========= ========= Total master_lag: -0.12 =========