builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1466805205.39 results: success (0) buildid: 20160624133259 builduid: e9573f5223514924a8f05d2dd3653582 revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.388062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.389343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.390131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.408355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.408991) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 14:53:25-- 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% 69.8M=0s 2016-06-24 14:53:25 (69.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.546176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.546554) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.596968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:25.597351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9dac1358aaadcea90aca05b170fc8bc59e097d52 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9dac1358aaadcea90aca05b170fc8bc59e097d52 --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=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 14:53:25,767 truncating revision to first 12 chars 2016-06-24 14:53:25,767 Setting DEBUG logging. 2016-06-24 14:53:25,767 attempt 1/10 2016-06-24 14:53:25,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9dac1358aaad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 14:53:26,065 unpacking tar archive at: mozilla-central-9dac1358aaad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.246540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.246848) ========= script_repo_revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.247259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.247553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:53:26.256056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 39 secs) (at 2016-06-24 14:53:26.256359) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:53:26 INFO - MultiFileLogger online at 20160624 14:53:26 in /builds/slave/test 14:53:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:53:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:26 INFO - {'append_to_log': False, 14:53:26 INFO - 'base_work_dir': '/builds/slave/test', 14:53:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:53:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:26 INFO - 'branch': 'Firefox-Non-PGO', 14:53:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:26 INFO - 'config_files': ('talos/linux_config.py',), 14:53:26 INFO - 'default_actions': ('clobber', 14:53:26 INFO - 'read-buildbot-config', 14:53:26 INFO - 'download-and-extract', 14:53:26 INFO - 'populate-webroot', 14:53:26 INFO - 'create-virtualenv', 14:53:26 INFO - 'install', 14:53:26 INFO - 'run-tests'), 14:53:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:26 INFO - 'download_minidump_stackwalk': True, 14:53:26 INFO - 'download_symbols': 'ondemand', 14:53:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:26 INFO - 'installer_path': 'installer.exe', 14:53:26 INFO - 'log_level': 'info', 14:53:26 INFO - 'log_name': 'talos', 14:53:26 INFO - 'log_to_console': True, 14:53:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:53:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:53:26 INFO - 'opt_config_files': (), 14:53:26 INFO - 'pip_index': False, 14:53:26 INFO - 'sps_profile': False, 14:53:26 INFO - 'sps_profile_interval': 0, 14:53:26 INFO - 'suite': 'dromaeojs-e10s', 14:53:26 INFO - 'system_bits': '32', 14:53:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:26 INFO - 'title': 'talos-linux64-ix-013', 14:53:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:26 INFO - 'use_talos_json': True, 14:53:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:26 INFO - 'work_dir': 'build'} 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running clobber step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: clobber 14:53:26 INFO - rmtree: /builds/slave/test/build 14:53:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:26 INFO - Running post-action listener: _resource_record_post_action 14:53:26 INFO - ##### 14:53:26 INFO - ##### Finished clobber step (success) 14:53:26 INFO - ##### 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running read-buildbot-config step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: read_buildbot_config 14:53:26 INFO - Using buildbot properties: 14:53:26 INFO - { 14:53:26 INFO - "project": "", 14:53:26 INFO - "product": "firefox", 14:53:26 INFO - "script_repo_revision": "production", 14:53:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:53:26 INFO - "repository": "", 14:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:53:26 INFO - "buildid": "20160624133259", 14:53:26 INFO - "pgo_build": "False", 14:53:26 INFO - "basedir": "/builds/slave/test", 14:53:26 INFO - "buildnumber": 362, 14:53:26 INFO - "slavename": "talos-linux64-ix-013", 14:53:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:53:26 INFO - "platform": "ubuntu64_hw", 14:53:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:53:26 INFO - "branch": "mozilla-central", 14:53:26 INFO - "repo_path": "mozilla-central", 14:53:26 INFO - "revision": "9dac1358aaadcea90aca05b170fc8bc59e097d52", 14:53:26 INFO - "stage_platform": "linux64", 14:53:26 INFO - "builduid": "e9573f5223514924a8f05d2dd3653582", 14:53:26 INFO - "slavebuilddir": "test" 14:53:26 INFO - } 14:53:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:53:26 INFO - Running post-action listener: _resource_record_post_action 14:53:26 INFO - ##### 14:53:26 INFO - ##### Finished read-buildbot-config step (success) 14:53:26 INFO - ##### 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running download-and-extract step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: download_and_extract 14:53:26 INFO - mkdir: /builds/slave/test/build/tests 14:53:26 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:53:26 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:53:27 INFO - Downloaded 1361 bytes. 14:53:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:53:27 INFO - Using the following test package requirements: 14:53:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:53:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:53:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'jsshell-linux-x86_64.zip'], 14:53:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:53:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:53:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:53:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:53:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:53:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:27 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:53:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:53:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:57:12 INFO - Downloaded 22710854 bytes. 14:57:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:57:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:57:13 INFO - Return code: 0 14:57:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:13 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:57:15 INFO - Downloaded 22710854 bytes. 14:57:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:57:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:57:16 INFO - Return code: 0 14:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:16 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:57:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:19 INFO - Downloaded 14405518 bytes. 15:01:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:01:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:01:19 INFO - Return code: 0 15:01: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')]} 15:01:19 INFO - https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:01:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:01:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:01:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:01:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:34 INFO - Downloaded 56261067 bytes. 15:01:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:01:34 INFO - mkdir: /builds/slave/test/properties 15:01:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:34 INFO - Contents: 15:01:34 INFO - build_url:https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:01:35 INFO - Running post-action listener: _resource_record_post_action 15:01:35 INFO - Running post-action listener: set_extra_try_arguments 15:01:35 INFO - ##### 15:01:35 INFO - ##### Finished download-and-extract step (success) 15:01:35 INFO - ##### 15:01:35 INFO - ##### 15:01:35 INFO - ##### Running populate-webroot step. 15:01:35 INFO - ##### 15:01:35 INFO - Running pre-action listener: _resource_record_pre_action 15:01:35 INFO - Running main action method: populate_webroot 15:01:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:35 INFO - '--tppagecycles', 15:01:35 INFO - '7'], 15:01:35 INFO - 'tests': ['tsvgm']}}, 15:01:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['damp', 'tps']}, 15:01:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'tests': ['damp', 'tps']}, 15:01:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['dromaeo_dom']}, 15:01:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['basic_compositor_video']}, 15:01:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['a11yr', 15:01:35 INFO - 'ts_paint', 15:01:35 INFO - 'tpaint', 15:01:35 INFO - 'sessionrestore', 15:01:35 INFO - 'sessionrestore_no_auto_restore', 15:01:35 INFO - 'tabpaint']}, 15:01:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['tsvgx', 15:01:35 INFO - 'tsvgr_opacity', 15:01:35 INFO - 'tart', 15:01:35 INFO - 'tscrollx', 15:01:35 INFO - 'cart']}, 15:01:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:35 INFO - 'tsvgr_opacity', 15:01:35 INFO - 'tart', 15:01:35 INFO - 'tscrollx', 15:01:35 INFO - 'cart']}, 15:01:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'talos_options': ['--disable-e10s'], 15:01:35 INFO - 'tests': ['tp5o']}, 15:01:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'tests': ['tp5o']}, 15:01:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'talos_options': ['--disable-e10s', 15:01:35 INFO - '--xperf_path', 15:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:35 INFO - 'tests': ['tp5n']}, 15:01:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:35 INFO - 'talos_options': ['--xperf_path', 15:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:35 INFO - 'tests': ['tp5n']}}, 15:01:35 INFO - 'talos.zip': {'path': '', 15:01:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:35 INFO - Running post-action listener: _resource_record_post_action 15:01:35 INFO - ##### 15:01:35 INFO - ##### Finished populate-webroot step (success) 15:01:35 INFO - ##### 15:01:35 INFO - ##### 15:01:35 INFO - ##### Running create-virtualenv step. 15:01:35 INFO - ##### 15:01:35 INFO - Running pre-action listener: _resource_record_pre_action 15:01:35 INFO - Running main action method: create_virtualenv 15:01:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:01:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:35 INFO - Using real prefix '/usr' 15:01:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:38 INFO - Installing pip.................done. 15:01:38 INFO - Return code: 0 15:01:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:38 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:38 INFO - Using env: {'DISPLAY': ':0', 15:01:38 INFO - 'HOME': '/home/cltbld', 15:01:38 INFO - 'LANG': 'en_US.UTF-8', 15:01:38 INFO - 'LANGUAGE': 'en_US:en', 15:01:38 INFO - 'LOGNAME': 'cltbld', 15:01:38 INFO - 'MAIL': '/var/mail/cltbld', 15:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:38 INFO - 'MOZ_NO_REMOTE': '1', 15:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:38 INFO - 'NO_EM_RESTART': '1', 15:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:38 INFO - 'PWD': '/builds/slave/test', 15:01:38 INFO - 'SHELL': '/bin/bash', 15:01:38 INFO - 'SHLVL': '1', 15:01:38 INFO - 'TERM': 'linux', 15:01:38 INFO - 'TMOUT': '86400', 15:01:38 INFO - 'USER': 'cltbld', 15:01:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:38 INFO - '_': '/tools/buildbot/bin/python'} 15:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:01:38 INFO - Cleaning up... 15:01:38 INFO - Return code: 0 15:01:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:38 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:01:38 INFO - Using env: {'DISPLAY': ':0', 15:01:38 INFO - 'HOME': '/home/cltbld', 15:01:38 INFO - 'LANG': 'en_US.UTF-8', 15:01:38 INFO - 'LANGUAGE': 'en_US:en', 15:01:38 INFO - 'LOGNAME': 'cltbld', 15:01:38 INFO - 'MAIL': '/var/mail/cltbld', 15:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:38 INFO - 'MOZ_NO_REMOTE': '1', 15:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:38 INFO - 'NO_EM_RESTART': '1', 15:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:38 INFO - 'PWD': '/builds/slave/test', 15:01:38 INFO - 'SHELL': '/bin/bash', 15:01:38 INFO - 'SHLVL': '1', 15:01:38 INFO - 'TERM': 'linux', 15:01:38 INFO - 'TMOUT': '86400', 15:01:38 INFO - 'USER': 'cltbld', 15:01:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:38 INFO - '_': '/tools/buildbot/bin/python'} 15:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:38 INFO - Downloading/unpacking psutil>=3.1.1 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:40 INFO - Installing collected packages: psutil 15:01:40 INFO - Running setup.py install for psutil 15:01:40 INFO - building 'psutil._psutil_linux' extension 15:01:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:01:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:01:40 INFO - building 'psutil._psutil_posix' extension 15:01:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:01:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:01:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:41 INFO - Successfully installed psutil 15:01:41 INFO - Cleaning up... 15:01:41 INFO - Return code: 0 15:01:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:41 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:41 INFO - Using env: {'DISPLAY': ':0', 15:01:41 INFO - 'HOME': '/home/cltbld', 15:01:41 INFO - 'LANG': 'en_US.UTF-8', 15:01:41 INFO - 'LANGUAGE': 'en_US:en', 15:01:41 INFO - 'LOGNAME': 'cltbld', 15:01:41 INFO - 'MAIL': '/var/mail/cltbld', 15:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:41 INFO - 'MOZ_NO_REMOTE': '1', 15:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:41 INFO - 'NO_EM_RESTART': '1', 15:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:41 INFO - 'PWD': '/builds/slave/test', 15:01:41 INFO - 'SHELL': '/bin/bash', 15:01:41 INFO - 'SHLVL': '1', 15:01:41 INFO - 'TERM': 'linux', 15:01:41 INFO - 'TMOUT': '86400', 15:01:41 INFO - 'USER': 'cltbld', 15:01:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:41 INFO - '_': '/tools/buildbot/bin/python'} 15:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:43 INFO - Installing collected packages: mozsystemmonitor 15:01:43 INFO - Running setup.py install for mozsystemmonitor 15:01:43 INFO - Successfully installed mozsystemmonitor 15:01:43 INFO - Cleaning up... 15:01:43 INFO - Return code: 0 15:01:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:01:43 INFO - Using env: {'DISPLAY': ':0', 15:01:43 INFO - 'HOME': '/home/cltbld', 15:01:43 INFO - 'LANG': 'en_US.UTF-8', 15:01:43 INFO - 'LANGUAGE': 'en_US:en', 15:01:43 INFO - 'LOGNAME': 'cltbld', 15:01:43 INFO - 'MAIL': '/var/mail/cltbld', 15:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:43 INFO - 'MOZ_NO_REMOTE': '1', 15:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:43 INFO - 'NO_EM_RESTART': '1', 15:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:43 INFO - 'PWD': '/builds/slave/test', 15:01:43 INFO - 'SHELL': '/bin/bash', 15:01:43 INFO - 'SHLVL': '1', 15:01:43 INFO - 'TERM': 'linux', 15:01:43 INFO - 'TMOUT': '86400', 15:01:43 INFO - 'USER': 'cltbld', 15:01:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:43 INFO - '_': '/tools/buildbot/bin/python'} 15:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:45 INFO - warning: no files found matching '*.txt' 15:01:45 INFO - no previously-included directories found matching 'build' 15:01:45 INFO - no previously-included directories found matching 'dist' 15:01:45 INFO - no previously-included directories found matching '.git*' 15:01:45 INFO - Installing collected packages: jsonschema, functools32 15:01:45 INFO - Running setup.py install for functools32 15:01:46 INFO - warning: no files found matching '*.txt' 15:01:46 INFO - no previously-included directories found matching 'build' 15:01:46 INFO - no previously-included directories found matching 'dist' 15:01:46 INFO - no previously-included directories found matching '.git*' 15:01:46 INFO - Successfully installed jsonschema functools32 15:01:46 INFO - Cleaning up... 15:01:46 INFO - Return code: 0 15:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:46 INFO - Using env: {'DISPLAY': ':0', 15:01:46 INFO - 'HOME': '/home/cltbld', 15:01:46 INFO - 'LANG': 'en_US.UTF-8', 15:01:46 INFO - 'LANGUAGE': 'en_US:en', 15:01:46 INFO - 'LOGNAME': 'cltbld', 15:01:46 INFO - 'MAIL': '/var/mail/cltbld', 15:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:46 INFO - 'MOZ_NO_REMOTE': '1', 15:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:46 INFO - 'NO_EM_RESTART': '1', 15:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:46 INFO - 'PWD': '/builds/slave/test', 15:01:46 INFO - 'SHELL': '/bin/bash', 15:01:46 INFO - 'SHLVL': '1', 15:01:46 INFO - 'TERM': 'linux', 15:01:46 INFO - 'TMOUT': '86400', 15:01:46 INFO - 'USER': 'cltbld', 15:01:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:46 INFO - '_': '/tools/buildbot/bin/python'} 15:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:49 INFO - Downloading docopt-0.6.1.tar.gz 15:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:49 INFO - Running setup.py install for blobuploader 15:01:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:49 INFO - Running setup.py install for requests 15:01:49 INFO - Running setup.py install for docopt 15:01:49 INFO - Successfully installed blobuploader requests docopt 15:01:49 INFO - Cleaning up... 15:01:49 INFO - Return code: 0 15:01:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:49 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:49 INFO - Using env: {'DISPLAY': ':0', 15:01:49 INFO - 'HOME': '/home/cltbld', 15:01:49 INFO - 'LANG': 'en_US.UTF-8', 15:01:49 INFO - 'LANGUAGE': 'en_US:en', 15:01:49 INFO - 'LOGNAME': 'cltbld', 15:01:49 INFO - 'MAIL': '/var/mail/cltbld', 15:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:49 INFO - 'MOZ_NO_REMOTE': '1', 15:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:49 INFO - 'NO_EM_RESTART': '1', 15:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:49 INFO - 'PWD': '/builds/slave/test', 15:01:49 INFO - 'SHELL': '/bin/bash', 15:01:49 INFO - 'SHLVL': '1', 15:01:49 INFO - 'TERM': 'linux', 15:01:49 INFO - 'TMOUT': '86400', 15:01:49 INFO - 'USER': 'cltbld', 15:01:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:49 INFO - '_': '/tools/buildbot/bin/python'} 15:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:49 INFO - Running setup.py (path:/tmp/pip-rxhJT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:49 INFO - Running setup.py (path:/tmp/pip-HgY_a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:50 INFO - Running setup.py (path:/tmp/pip-UdolSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:50 INFO - Running setup.py (path:/tmp/pip-8yaKVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:50 INFO - Running setup.py (path:/tmp/pip-IxTRyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:50 INFO - Running setup.py (path:/tmp/pip-qaQeFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:50 INFO - Running setup.py (path:/tmp/pip-I_F1LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:50 INFO - Running setup.py (path:/tmp/pip-heusHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:50 INFO - Running setup.py (path:/tmp/pip-M79q22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:50 INFO - Running setup.py (path:/tmp/pip-QkdCaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:50 INFO - Running setup.py (path:/tmp/pip-dH5djE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:50 INFO - Running setup.py (path:/tmp/pip-OT7Awp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:50 INFO - Running setup.py (path:/tmp/pip-2nvvPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:50 INFO - Running setup.py (path:/tmp/pip-XIO2TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:50 INFO - Running setup.py (path:/tmp/pip-K1od0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:51 INFO - Running setup.py (path:/tmp/pip-mlsnHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:51 INFO - Running setup.py (path:/tmp/pip-5HmgoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:51 INFO - Running setup.py install for manifestparser 15:01:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozcrash 15:01:51 INFO - Running setup.py install for mozdebug 15:01:51 INFO - Running setup.py install for mozdevice 15:01:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozfile 15:01:51 INFO - Running setup.py install for mozhttpd 15:01:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozinfo 15:01:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozInstall 15:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozleak 15:01:52 INFO - Running setup.py install for mozlog 15:01:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Running setup.py install for moznetwork 15:01:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Running setup.py install for mozprocess 15:01:52 INFO - Running setup.py install for mozprofile 15:01:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Running setup.py install for mozrunner 15:01:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Running setup.py install for mozscreenshot 15:01:52 INFO - Running setup.py install for moztest 15:01:52 INFO - Running setup.py install for mozversion 15:01:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:52 INFO - Cleaning up... 15:01:52 INFO - Return code: 0 15:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:52 INFO - Using env: {'DISPLAY': ':0', 15:01:52 INFO - 'HOME': '/home/cltbld', 15:01:52 INFO - 'LANG': 'en_US.UTF-8', 15:01:52 INFO - 'LANGUAGE': 'en_US:en', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MAIL': '/var/mail/cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SHLVL': '1', 15:01:52 INFO - 'TERM': 'linux', 15:01:52 INFO - 'TMOUT': '86400', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - '_': '/tools/buildbot/bin/python'} 15:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Running setup.py (path:/tmp/pip-gwhIxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Running setup.py (path:/tmp/pip-UvTld4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Running setup.py (path:/tmp/pip-yG1Stk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Running setup.py (path:/tmp/pip-4og9CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Running setup.py (path:/tmp/pip-HZ6Lno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Running setup.py (path:/tmp/pip-JV7Mey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Running setup.py (path:/tmp/pip-TsfTvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Running setup.py (path:/tmp/pip-OHQD24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Running setup.py (path:/tmp/pip-QRn76p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:53 INFO - Running setup.py (path:/tmp/pip-tYZ3q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:53 INFO - Running setup.py (path:/tmp/pip-Bl3k6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:53 INFO - Running setup.py (path:/tmp/pip-iVHE9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:54 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)) 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Running setup.py (path:/tmp/pip-qMa48e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 INFO - Running setup.py (path:/tmp/pip-bKSVVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 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)) 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Running setup.py (path:/tmp/pip-kA7x7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Running setup.py (path:/tmp/pip-y3ECCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Running setup.py (path:/tmp/pip-K1_1JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:56 INFO - Downloading blessings-1.6.tar.gz 15:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:56 INFO - Installing collected packages: blessings 15:01:56 INFO - Running setup.py install for blessings 15:01:56 INFO - Successfully installed blessings 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:56 INFO - Reading from file tmpfile_stdout 15:01:56 INFO - Current package versions: 15:01:56 INFO - argparse == 1.2.1 15:01:56 INFO - blessings == 1.6 15:01:56 INFO - blobuploader == 1.2.4 15:01:56 INFO - docopt == 0.6.1 15:01:56 INFO - functools32 == 3.2.3-2 15:01:56 INFO - jsonschema == 2.5.1 15:01:56 INFO - manifestparser == 1.1 15:01:56 INFO - mozInstall == 1.12 15:01:56 INFO - mozcrash == 0.17 15:01:56 INFO - mozdebug == 0.1 15:01:56 INFO - mozdevice == 0.48 15:01:56 INFO - mozfile == 1.2 15:01:56 INFO - mozhttpd == 0.7 15:01:56 INFO - mozinfo == 0.9 15:01:56 INFO - mozleak == 0.1 15:01:56 INFO - mozlog == 3.2 15:01:56 INFO - moznetwork == 0.27 15:01:56 INFO - mozprocess == 0.22 15:01:56 INFO - mozprofile == 0.28 15:01:56 INFO - mozrunner == 6.11 15:01:56 INFO - mozscreenshot == 0.1 15:01:56 INFO - mozsystemmonitor == 0.3 15:01:56 INFO - moztest == 0.7 15:01:56 INFO - mozversion == 1.4 15:01:56 INFO - psutil == 3.1.1 15:01:56 INFO - requests == 1.2.3 15:01:56 INFO - wsgiref == 0.1.2 15:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:56 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:56 INFO - Using env: {'DISPLAY': ':0', 15:01:56 INFO - 'HOME': '/home/cltbld', 15:01:56 INFO - 'LANG': 'en_US.UTF-8', 15:01:56 INFO - 'LANGUAGE': 'en_US:en', 15:01:56 INFO - 'LOGNAME': 'cltbld', 15:01:56 INFO - 'MAIL': '/var/mail/cltbld', 15:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:56 INFO - 'MOZ_NO_REMOTE': '1', 15:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:56 INFO - 'NO_EM_RESTART': '1', 15:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:56 INFO - 'PWD': '/builds/slave/test', 15:01:56 INFO - 'SHELL': '/bin/bash', 15:01:56 INFO - 'SHLVL': '1', 15:01:56 INFO - 'TERM': 'linux', 15:01:56 INFO - 'TMOUT': '86400', 15:01:56 INFO - 'USER': 'cltbld', 15:01:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:56 INFO - '_': '/tools/buildbot/bin/python'} 15:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:01:57 INFO - Using env: {'DISPLAY': ':0', 15:01:57 INFO - 'HOME': '/home/cltbld', 15:01:57 INFO - 'LANG': 'en_US.UTF-8', 15:01:57 INFO - 'LANGUAGE': 'en_US:en', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MAIL': '/var/mail/cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SHLVL': '1', 15:01:57 INFO - 'TERM': 'linux', 15:01:57 INFO - 'TMOUT': '86400', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - '_': '/tools/buildbot/bin/python'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0x7f51660e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a6350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:01:57 INFO - Using env: {'DISPLAY': ':0', 15:01:57 INFO - 'HOME': '/home/cltbld', 15:01:57 INFO - 'LANG': 'en_US.UTF-8', 15:01:57 INFO - 'LANGUAGE': 'en_US:en', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MAIL': '/var/mail/cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SHLVL': '1', 15:01:57 INFO - 'TERM': 'linux', 15:01:57 INFO - 'TMOUT': '86400', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - '_': '/tools/buildbot/bin/python'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Downloading/unpacking flake8 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:01:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:01:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:00 INFO - no previously-included directories found matching 'docs/_build' 15:02:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:00 INFO - Running setup.py install for pep8 15:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:00 INFO - no previously-included directories found matching 'docs/_build' 15:02:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:02:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:00 INFO - Cleaning up... 15:02:00 INFO - Return code: 0 15:02:00 INFO - Running post-action listener: _resource_record_post_action 15:02:00 INFO - Running post-action listener: _start_resource_monitoring 15:02:00 INFO - Starting resource monitoring. 15:02:00 INFO - ##### 15:02:00 INFO - ##### Finished create-virtualenv step (success) 15:02:00 INFO - ##### 15:02:00 INFO - ##### 15:02:00 INFO - ##### Running install step. 15:02:00 INFO - ##### 15:02:00 INFO - Running pre-action listener: _resource_record_pre_action 15:02:00 INFO - Running main action method: install 15:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:00 INFO - Reading from file tmpfile_stdout 15:02:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:00 INFO - Reading from file tmpfile_stdout 15:02:00 INFO - Output received: 15:02:00 INFO - Usage: mozinstall [options] installer 15:02:00 INFO - Options: 15:02:00 INFO - -h, --help show this help message and exit 15:02:00 INFO - -d DEST, --destination=DEST 15:02:00 INFO - Directory to install application into. [default: 15:02:00 INFO - "/builds/slave/test"] 15:02:00 INFO - --app=APP Application being installed. [default: firefox] 15:02:00 INFO - mkdir: /builds/slave/test/build/application 15:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:02:16 INFO - Reading from file tmpfile_stdout 15:02:16 INFO - Output received: 15:02:16 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:16 INFO - Running post-action listener: _resource_record_post_action 15:02:16 INFO - ##### 15:02:16 INFO - ##### Finished install step (success) 15:02:16 INFO - ##### 15:02:16 INFO - ##### 15:02:16 INFO - ##### Running run-tests step. 15:02:16 INFO - ##### 15:02:16 INFO - Running pre-action listener: _resource_record_pre_action 15:02:16 INFO - Running main action method: run_tests 15:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:16 INFO - Python 2.7.3 15:02:16 INFO - Return code: 0 15:02:16 INFO - grabbing minidump binary from tooltool 15:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:16 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 0x2a351c0>, '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 0x2a360c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a36550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:02:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:16 INFO - Return code: 0 15:02:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:02:17 INFO - Return code: 0 15:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:02:17 INFO - Using env: {'DISPLAY': ':0', 15:02:17 INFO - 'HOME': '/home/cltbld', 15:02:17 INFO - 'LANG': 'en_US.UTF-8', 15:02:17 INFO - 'LANGUAGE': 'en_US:en', 15:02:17 INFO - 'LOGNAME': 'cltbld', 15:02:17 INFO - 'MAIL': '/var/mail/cltbld', 15:02:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:17 INFO - 'MOZ_NO_REMOTE': '1', 15:02:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:17 INFO - 'NO_EM_RESTART': '1', 15:02:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:17 INFO - 'PWD': '/builds/slave/test', 15:02:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:17 INFO - 'SHELL': '/bin/bash', 15:02:17 INFO - 'SHLVL': '1', 15:02:17 INFO - 'TERM': 'linux', 15:02:17 INFO - 'TMOUT': '86400', 15:02:17 INFO - 'USER': 'cltbld', 15:02:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996', 15:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:17 INFO - '_': '/tools/buildbot/bin/python'} 15:02:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:02:18 INFO - mozversion application_buildid: 20160624133259 15:02:18 INFO - mozversion application_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 15:02:18 INFO - mozversion application_display_name: Nightly 15:02:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:18 INFO - mozversion application_name: Firefox 15:02:18 INFO - mozversion application_remotingname: firefox 15:02:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:02:18 INFO - mozversion application_vendor: Mozilla 15:02:18 INFO - mozversion application_version: 50.0a1 15:02:18 INFO - mozversion platform_buildid: 20160624133259 15:02:18 INFO - mozversion platform_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 15:02:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:02:18 INFO - mozversion platform_version: 50.0a1 15:02:18 INFO - using testdate: 1466805738 15:02:18 INFO - actual date: 1466805738 15:02:18 INFO - starting webserver on 'localhost:47227' 15:02:18 INFO - SUITE-START | Running 2 tests 15:02:18 INFO - TEST-START | dromaeo_css 15:02:18 INFO - operating with platform_type : linux_ 15:02:18 INFO - Initialising browser for dromaeo_css test... 15:02:18 INFO - TEST-INFO | started process 2190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5cobbR/profile http://localhost:47227/getInfo.html) 15:02:23 INFO - PROCESS | 2190 | __metrics Screen width/height:1600/1200 15:02:23 INFO - PROCESS | 2190 | colorDepth:24 15:02:23 INFO - PROCESS | 2190 | Browser inner width/height: 1024/697 15:02:23 INFO - PROCESS | 2190 | __metrics 15:02:24 ERROR - PROCESS | 2190 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:02:25 INFO - TEST-INFO | 2190: exit 0 15:02:25 INFO - Browser initialized. 15:02:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:25 INFO - TEST-INFO | started process 2308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5cobbR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:37 INFO - PROCESS | 2308 | RSS: Main: 186605568 15:02:37 INFO - PROCESS | 2308 | 15:03:26 INFO - PROCESS | 2308 | 1466805806939 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:05:39 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47227/tests/dromaeo/cssquery-ext.html) 15:05:40 INFO - PROCESS | 2308 | RSS: Main: 189087744 15:05:40 INFO - PROCESS | 2308 | 15:08:42 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-ext.html (next: http://localhost:47227/tests/dromaeo/cssquery-jquery.html) 15:08:43 INFO - PROCESS | 2308 | RSS: Main: 187940864 15:08:43 INFO - PROCESS | 2308 | 15:11:45 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47227/tests/dromaeo/cssquery-mootools.html) 15:11:45 INFO - PROCESS | 2308 | RSS: Main: 189059072 15:11:45 INFO - PROCESS | 2308 | 15:14:47 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47227/tests/dromaeo/cssquery-prototype.html) 15:14:48 INFO - PROCESS | 2308 | RSS: Main: 186920960 15:14:48 INFO - PROCESS | 2308 | 15:17:50 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47227/tests/dromaeo/cssquery-yui.html) 15:17:51 INFO - PROCESS | 2308 | RSS: Main: 189030400 15:17:51 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | Cycle 1(1): loaded http://localhost:47227/tests/dromaeo/cssquery-yui.html (next: http://localhost:47227/tests/dromaeo/cssquery-dojo.html) 15:20:54 INFO - PROCESS | 2308 | RSS: Main: 190083072 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | __start_tp_report 15:20:54 INFO - PROCESS | 2308 | _x_x_mozilla_page_load 15:20:54 INFO - PROCESS | 2308 | _x_x_mozilla_page_load_details 15:20:54 INFO - PROCESS | 2308 | |i|pagename|runs| 15:20:54 INFO - PROCESS | 2308 | |0;dojo.html;2676.1837639519945;2724.359775452768;2733.5489644208706;2742.2595899107255;2745;4850.175470170071;4866.051120031595;4899.755012249391;4975.427825800034;5008.273800298964;4808.422989241287;4833.32333473314;4919.311296418504;4955.083309587729;4961.305417241589;4381.802818873159;4402.515723270446;4449.221386257408;4528.230200865861;4530.22986092365;4190.7485550866895;4479.932801007987;4514.04285849522;4518.97740511297;4579.038401935598;4419.226635338803;4450.221211288044;4476.082403107355;4498.910021799546;4544.091181763644;4482.327650852366;4509.301058335963;4574.382458368111;4576.8626941191815;4603;4509.932351014738;4521.389612402317;4555.339475775994;4564.201264778683;4598.816047358102;4816.831410900601;4860.343853579757;4878.609711223094;4908.680935739166;4910.828121015783;5230.503102205284;5231.973840130813;5235.319408476912;5249.212618107276;5263.657862238981;5040.571551418134;5067.87330316745;5271.367435907678;5282.445343238943;5300;4815.686980346301;4844.128056949748;4858.659893807399;4865.9026819464125;4893.926591101136;5339.172428273624;5348.893022139536;5352.304200453916;5367.35591728995;5398.406175320712;5011.974940125276;5102.36220472441;5135.537801597874;5150.459201783834;5165.767540460688;5105.5149760772665;5205.687658740488;5280.1815718563685;5296.126139186991;5331.946680533222;5119.385673719103;5122.359705036871;5176.042432150064;5205.609579281569;5220.686758794484;5009.7495125243595;5174.560162386239;5176;5179.456157103526;5235.502627250406;4364.978175109104;4405.515393306734;4426.15902978433;4434.84478043267;4452.755098469551;3845.788481633481;3864.942025869614;3869.4582758413844;3899.512560929884;3910.648041676263;4477.485089214717;4550.567696068868;4616.76916154191;4624.884377890579;4672.76636168197;5291.76187071575;5352.785888564492;5353.544948679406;5385.057614917374;5409.891802164014;4545.250033744395;4604.424446944132;4604.58558729716;4625.236835922035;4647.581717645428;4576.519465456146;4698.389209402824;4746.1931471649905;4747.335373047776;4810.7835147418455;4929.06347793918;4950.975245123751;4955.331030310862;4967.677100988352;4994.375703037121;5288.920666189933;5323.813666521653;5328.973355133199;5333.359996800409;5367.3827509836865;4818.542238487338;4844.8304309349005;4878.56092951636;4900.534449227318;4969.453360130455;5120.18077107661;5122.052420302256;5124.052050370693;5144.254083157846;5194.194899790538;5186.429492755869;5190.273361729436;5192.948070519246;5230.241614965885;5235.188545775411;4952.4057113146655;4963.429205641253;5094.872628184325;5107.974460127824;5144.356955380577;4980.726060066731;5039.748012599429;5080.26336181259;5084.2881996521255;5096.286519887145;4995.400551933792;5044.243363495505;5046.21783623539;5056.924146137737;5070.391553013662;5030.295758593873;5087.186050231945;5126.6923984561045;5138.511841375063;5163.406208285945;5013.949860501349;5036.420811606712;5041.899162016813;5064.290999260033;5106.259592359162 15:20:54 INFO - PROCESS | 2308 | |1;ext.html;530.8823321037394;578.1385735254471;586.4575267877212;604.1572007050164;609.6372658268328;35844.46233306499;39205.60794392055;39316.80341598288;39474.210515789666;39490.802545987266;39326.606733932655;39861.80069099658;40125.598744012554;40136.59863401365;40170.19659606806;7781.494202876823;7904.4862083964645;7906.762797116067;7921.287084162424;7927.1676473970265;7693.846123077535;7843.294103530681;7857.764267071997;7869.252421020023;7873.055233372003;7884.960575197116;7889.8816517752275;7922.445428819985;7925.445218834684;7928.286454219119;7833.334166595818;7843.176466471024;7873;7892.092409372938;7907.327877130451;7783.455158138932;7836.686532538692;7874.881876771853;7881.960590197013;7889.684412623488;37731;37861;38059.23881522354;38196.236075278335;38219.8089009556;3250.8862189823244;3316.219927168511;3461.6538346165435;3649.7262705296944;3860.1700634363747;29117.417651646847;29286.267843303875;29438;29576;29719.40561188764;3013.171377871081;3188.2348236423322;3191.505316675919;3192.058342788883;3195.265089029513;259040;259046;260992;261395.69302153558;262636;52620.473795262325;52768;53222.467775321755;53304.86780528813;53341.1992920639;54788.72605637026;55056;55261.72369138209;55287.723561381936;55388;14769.63075923089;14855.182964937032;14885.255737213096;14891.925540372446;14991.17548534841;11855.881441185478;12030.63908082759;12051.035917126608;12077.698057548632;12159.574414895436;14030.228337441335;15634.843651563338;15721.213939302988;15868.52394428169;15942.123183224801;5798.362180160179;6116.602420842631;6153.569250152446;6158.907616385758;6244.094606282155;822.9547374894438;884.7127429589931;899.3524662243175;905.4702998745807;984.8621193032981;27913.581296280572;28151.296217594314;28364.574531382044;28755.2811179718;28888.27779305492;960.711786464058;965.5124162297994;1010.1716592394313;1051.4059556350637;1104.9060829829393;14249.073810202512;14404.135751854923;14531.418743250362;14606.85393146055;14712.55862324132;364265;364519;367331;371002;372586;50644.49355506471;50725.492745072814;50874;51031;51101;1119.367557330106;1199.4542483170137;1231.9076069294838;1232.4700378837006;1240.8883200511998;27371.589426158225;28408.431831362843;28857.278568035126;29102.27244318909;29258.414831703674;41481.170376592905;41638.37542436927;42041;42108.368374473794;42271.57728422676;289362;290067;290550;291253;292342;23665.171718989754;24978;25061.87469062643;25091.87454062718;25103.493790372635;41076.589234107276;41147.1770564593;42101.78949105235;42730.572694273906;43134.137317254106;35617.82191089028;35805.46291805677;36300.81849590735;36397.818010909774;36568.26863462769;35063.64936350604;35649;35781.46327805033;35949.22533133983;36111.63888361083;35576.64423355733;35891.820540897126;35982.28035439329;37450;37507.24985500329;31491;32880.67119328776;33584.66415335816;33628.663713362555;33662.66337336693;25381.873090634428;25865;25888.482230355665;25941;26382.604260935717 15:20:54 INFO - PROCESS | 2308 | |2;jquery.html;371.46509027001116;371.6265153520711;373.8429859459028;388.4852570344294;394.61919247925744;10401.167906567476;10897.945510272457;10957.671269861898;10976.451177441117;16072.678546429079;17423.215955282012;17577.73633395497;18355.449336519927;19239;19239.23043078275;5466.890662186754;5497.367802702691;5678.630888992202;5795.072788353864;5795.1886735857015;4045.231406032859;5626.268585083933;6440.806775796734;6833.111695479581;6835.487338449611;6228.22147231596;6922.723091076351;6937.618430986294;6944.444444444458;6947.131608548932;6680.933190668104;6749.527533072687;6805.965970170167;6846.418054465352;6855.1088358513325;6695.497837662195;6766.221884483249;6826.146731658543;6830.112085428863;6857.897131543031;21585.352439426842;22288.777112228832;23524.76475235243;23711.1701090461;23856.64215036776;2101.2960658179527;2110.5778844231063;2160.25471212433;2164.448065743241;2208.293346129239;13639.318034098256;14304.499342523066;14701;14785.11289322644;14820.555383338517;1821.854251659864;1824.1244202782607;1848.6210326882956;1889.4520589029164;1945.1246938877562;78052;80353.59823200906;81509.59245203737;82153.17846821574;84924.99999999939;15639.921800390925;16479.258433370527;16650.83349166517;17217.91391043037;17760.111994400228;28698.42603147967;28881.56677649837;29232;29307.069293070523;29457.263568410533;8847.938247410351;9148.222401095849;9159.908400915905;9282.72151835446;9471.76320591977;7602.7339043133225;7671.424643151786;7730.961345193238;7764.844703105906;7818.452708310478;8044.597770111588;8166.469179503313;8315;8455.492670439793;8530.914690853013;1505.1796770759963;1573.732465480871;1617.5713435939485;1638.7787648667277;1646.2756387189597;909.5725009245645;922.8800255966815;951.4529145741227;962.1581116523042;980.2941881845203;16402.507924762278;16697.49907502777;16737.665246694996;16756.832431675528;17118.229679664444;868.9485722276116;877.8024944387589;885.8051228729669;895.3956079646213;947.8151760406655;9183.127602877716;9553.140217380469;9587.760305992266;9720.125188733047;9856.852147217798;258480;265814;413559;413655;417495;80656;80939.59530202429;81390;84735.15264847396;85067;911.334725650279;950.2208189284859;958.9136977672043;997.9870431512021;1000.7698229407132;12666.809997849856;14598.197099159648;15897.205139742735;15920.601984950006;16334.591635209215;29879.55180672248;35623.10942226465;36817;37635.24729505449;38502;44561.331580025675;47278.52721472879;47433.76283118701;48192.27711584259;54289.45710542844;7407.185209627044;7600.923990760243;7813.609319534115;7816.179301173523;7932.444728868923;8829.514376709343;9789.559469824018;11512.654620361403;11721.882781172078;11809.822852657046;9922.107010369102;10123.898761012295;10187.592496300065;10543.31468454548;10594.364338139736;10326.741831454274;10704.464776761286;10749.946250268698;10753.516091775733;10832.620858269922;10555.261131721012;10585.788284234426;10817.891821081688;10905.890941090487;11038.17213708991;7934.56359900211;7941.801454963672;7959.283664470226;7976.282134607914;7992.080910695345;7986.161453047579;10078.8488172676;10381.53283102247;10432.58269669235;10692.305000174963 15:20:54 INFO - PROCESS | 2308 | |3;mootools.html;1349.2174538767515;1379.972400551989;1449.869511743943;1621.4892308922697;1632.1023437109602;6701;7344.559326440417;7437.814054648637;7805.531668099904;7839.0985036720795;7468.51454655447;7721.420893433001;7787.532748035122;7794.961025194866;7826.1391246962785;2199.626063569197;2248.651459023854;2250.707408036961;2257.7064981552376;2260.638297872341;2236.7539570647295;2248.022110381989;2268.875211863347;2270.8751018693965;2281.6805647209403;2196.615592271346;2222.2333295013277;2224.177054489841;2246.3261021693506;2254.1546919905036;2097.937061888138;2101.6637338025844;2121.1939463004037;2132.8400369972314;2183.257692384589;2194.133317339658;2219.4562332228707;2224.799768020886;2227.955440891173;2229.6321107017325;7822.530648161129;7858.332041776456;7881.921180788233;7883.960580197119;7912.564808935506;4537.3647689323525;4657.813687452498;4668.486466488684;4676.906461870778;4682.836100736458;2858.571214317848;3007.774416918718;3036.05882176526;3078.569000339954;3093.056617731591;948.4119845695644;966.0050148347214;984.9064338887795;1619.7651340555672;1637.4596383193518;10444.529996150191;10470.42412667303;10525.421101839396;10545.261831671785;10576.36541807494;4050.4531888194715;4104.8768536943935;4161.271777438997;4193.580641935843;4201.390798334285;8340.124286949784;8355.206255405727;8362.498250105013;8364.958175209207;8382;4446.044100518339;4463.419755431773;4503.797329120198;4505.549445055533;4508.977455112704;3519.454484554898;4180.790960452026;4194.937075943863;4242.978785106055;4345.022369966732;3478.443449048191;3509.78941263525;3583.1937813991644;3620.2216523447587;3620.7827530348263;1042.588177669816;1073.7154654016535;1080.4651697409834;1095.59462998691;1104.8342748587777;675.3111825937516;713.3294702979183;785.1677222144431;795.3445175568602;807.3702512040618;4896.314515967767;5079.390473143247;5104.336436263262;5145.434002259748;5253.527182553512;410.1202919737147;410.43974974160056;414.47154877531386;415.93345064790094;422.3327143113873;3353.346097510962;3494.9126271843406;3507.4563442666426;3517.8944631661093;3530.276293359855;9235.676751313671;9643.469609171423;9644.228461723185;9745.951270243604;9775.804483910424;9561.569729362196;9642.566084526214;9646.372985755903;9649.662261820802;9699.51502424876;6801.149856267966;7092.964535177394;7175.964120179366;7338.119425668847;7348.081489813773;5060.8987820242655;5154.252633368215;5257.894842103213;5339.7597108131;5344.759485823225;8739.650413983369;8848.601812918305;8981.416207946462;9009.099090090938;9047;8853.15894989975;9068.093190680878;9080.364374493722;9104.13510716481;9107;6025.457708806229;6529.249136349381;6740.730370785113;6777.356151165632;6913.827154320981;7519.511231769918;7535.434842386952;7555.471117021756;7568.735094271674;7588.924110758821;6316.589421687576;6320.209973753281;6374.235091789015;6510.088587597835;6644.368784965421;6074.210352654127;6195.659238741912;6252.999520076766;6316.557840951089;6407.295197528175;6170.352113028068;6245.156903818108;6280.27776805655;6287.497000240061;6289.056641503811;4587.931181032221;4690.742009189391;4733.8343157990685;4808.06242782654;4837.806487740451;4596.908061838678;4612.74629895359;4626.37543931565;4637.072585482984;4673.299005149255 15:20:54 INFO - PROCESS | 2308 | |4;prototype.html;301.4107419993911;303.3811025507963;311.11953172521766;311.5498105237932;315.43851943540506;5090.134677104892;5094.490550944908;5112.207607820789;5135.255387968742;5175.1461008933575;5012.571417146114;5014.523620256079;5017.322661440704;5019.372578427697;5025.2462130680415;3742.681872040873;3872.0319920019997;3953.3674612062077;3960.4455376247347;3970.7617542947373;3982.5818289079666;3985.9437249129005;3993.5008123984503;4005.699572532057;4015.759054456742;3957.872006478154;3976.5485597756756;3981.86063487778;3990.6009399060154;3991.580884007181;3688.9262214755554;3919.2357490289405;3923.9803800980812;3966.9999999999854;3968.285708572456;3382.391169589473;3390.8982730518123;3397.8980630581123;3408;3416.8804091856914;4919;4938.950610493921;4945;4946.9010619787405;4969.279454479117;4172.812223449952;4450.354698568722;4478.193925093482;4487.775611219426;4532.8866778330475;5299.258103865462;5308.946910530923;5326.680399176062;5351.9296140772;5352.946470535284;3782.130110074698;3783.4324851272254;3786.678132358753;3797.316483033053;3798.3352913240074;5362.865928351784;5570.359408667974;5595.916061259084;5605;5630.746616402272;3831.272058308912;3843.9807800961376;3846.442265871489;3850.383938569815;3860.2279544091293;3887.7667339959694;3900.414937759359;3904.9219015620097;3908.257431088084;3918.2163567286657;4465.437097016018;4475.507694153641;4485.730856148642;4487.887802804956;4500.459944806644;5169.948300516947;5273.736313184326;5279.805717540909;5281.577473802086;5417.702026388508;1319.907606467538;1333.6932505523785;1336.245021562814;1342.328835582209;1346.8888167262048;820.2822530285999;841.3984001439001;842.7527259655744;849.180540778152;850.2305413600701;4636.768161591907;4639.86080417588;4641.071785642885;4645.419322584677;4675.485696573374;5397.2443857859935;5418.214358917935;5450.618456707993;5466.453354664502;5487.5609951203805;4503.279475283939;4630.83792067276;4662.650301227422;4664.370310008173;4684.859454216379;2892.7107289270903;2895.4932886744737;2901.8113822601886;2914.825110493377;2922.167182353019;5063.759378952181;5095.159298715745;5107.693538387709;5124.56441202502;5132.153194722903;5406.675599464044;5475.863103422366;5553.944460555424;5590.077637189899;5596.720163991866;5067.341245638044;5118.74406279692;5135.768890399941;5160.354955630546;5167.793288268427;5389.919151212814;5454.127339625641;5464.945350546603;5476.397596264487;5539.169124631177;5040.84877453677;5261.921071183859;5326.707031113326;5343.492368225013;5365.543928766098;5084.288199651977;5090.949090509195;5121.231815227746;5142.043325088164;5149.510796474329;3833.2333533292895;3835.328817456878;3844.2695887781233;3857.363535016803;3859.4982652255026;5327.3074500314715;5383.300170977748;5431.56063643127;5438.23864658956;5473.124300111963;5312.840614781563;5329.57363410934;5336.279602253646;5336.546393556591;5375.3280839895015;5050.3182070420025;5283.524482796567;5304.920426193533;5318.574514038945;5376.435474275145;5159.251908473326;5166.2508936203285;5168.870778230575;5170.741462926763;5185.9222111667605;5084.6440749147205;5207.192885102815;5342.572594192377;5360.70516121617;5400.7569659364635;5170.922436163385;5200.089984252665;5201.271821945006;5213.478652134756;5227.817026404057 15:20:54 INFO - PROCESS | 2308 | |5;yui.html;654.6203202142758;688.9379955803978;696.6725638949695;722.559238864293;745.500514655181;12440.502379904805;13335.778506924125;13545.322733863304;13551.186928784267;13584.388702508386;11419;11687.7078073048;11763.823542646867;11782.823257651142;11790.882091179086;605.4944121658399;760.5132715062337;779.3803925878925;789.4552758596578;791.2285521616407;788.9566073865935;793.3970182661161;793.623029061197;796.2992566541465;801.8556659801234;837.0374069819726;842.4145219072716;845.4166625028741;845.6997765793147;845.8773477845708;835.7534527314426;836.1262480707645;838.739990602909;838.995805020971;839.1189251286125;607.6232735703848;608.4159207161131;609.165443342619;609.3236507476697;610.0635524469917;13625.863741362658;13808;13815.585532434043;13823.51617693376;13866.791998120036;13623.727525449534;13748;13825.585232443043;13837.723245535033;13925.860741392658;10827.891721082768;10902.182336324808;11138.27601205919;11141.888581114166;11295.49170287339;3371.511130886008;3397.711194548466;3399.5920489541168;3437.1407148212948;3439.6044454887756;61997.380026199615;62427.37572624261;64510.677446612935;64786;64865.67567162134;10576.471176441148;10702.571897124184;10785.298955567863;10785.406802625774;10870.402127883042;20163.697544536844;20300.593988120156;20354.89822550878;20738.688919666216;20957.161713531288;7024.332688394697;7070.186928503288;7080.221175670672;7095.113110861143;7172.641367931687;3811.8094095295123;3879.534455865314;3912.68698504119;3935.626115519021;3942.704297177666;2907.2877145099164;3021.4561378952;3022.9848850755607;3029.8636561354792;3031.4088752693456;491.40785353648766;506.3973871093387;506.6326912988128;510.01312460389266;510.0538501080516;491.1968930798171;565.0817421689754;568.5650477384804;577.1458241802072;579.2787978966214;7237.674304656303;7614.466987310835;7803.609819509002;7863.646135923897;8254.793630159174;480.82690231516625;548.5803360429275;564.4214679953081;580.3702982264291;598.5809933046885;3421.674940880612;3570.910727231788;3585.6772890439984;3653.9817300913323;3713.5729391119826;99479;100747.49626251968;104934.47532762287;105075;106900.46549767202;54542;63759.362406375345;84934.57532712296;88796.23241443436;89614.55192723994;61290;83414.58292708498;83781;83908.58045709733;84690.57654711687;6790.8641827164165;6972.930270697431;6993.055937448379;7049.471289653194;7244.058272424551;42264.36603451012;46283.305750414445;46579.43813090177;46663.30005049995;46869.765651171525;66808.66595666991;69725;70216.64891675509;70533;70727.64636176787;10139.695809125738;10324.896751032393;10474.633387831389;10487.115445014664;10559.683209503728;11118.953416704748;11164.888351116384;11198.272112312674;11316.20786544934;12135.514579416724;9904.158146557624;10284.382937023802;10362.171026318027;10372.844407334047;10715.928407159221;10786.946065269623;11240.775184496428;11248.212625116163;11265.549378025114;11507.021903138328;10065.24510661718;10552.103071239031;10819.945900270448;10900.672979810619;11023.83464248021;8415.663373464993;8505.192006759347;8607.309579858596;8731.083236260101;9112.316576256675;8786.780330491789;8919.777005574913;8988.10118988096;9049.638014479347;9283.76790580241 15:20:54 INFO - PROCESS | 2308 | __end_tp_report 15:20:54 INFO - PROCESS | 2308 | __start_cc_report 15:20:54 INFO - PROCESS | 2308 | _x_x_mozilla_cycle_collect,396 15:20:54 INFO - PROCESS | 2308 | __end_cc_report 15:20:54 INFO - PROCESS | 2308 | __startTimestamp1466806854497__endTimestamp 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | ------- Summary: start ------- 15:20:54 INFO - PROCESS | 2308 | Number of tests: 6 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#0] dojo.html Cycles:165 Average:4837.39 Median:4967.68 stddev:506.66 (10.2%) stddev-sans-first:479.01 15:20:54 INFO - PROCESS | 2308 | Values: 2676.2 2724.4 2733.5 2742.3 2745.0 4850.2 4866.1 4899.8 4975.4 5008.3 4808.4 4833.3 4919.3 4955.1 4961.3 4381.8 4402.5 4449.2 4528.2 4530.2 4190.7 4479.9 4514.0 4519.0 4579.0 4419.2 4450.2 4476.1 4498.9 4544.1 4482.3 4509.3 4574.4 4576.9 4603.0 4509.9 4521.4 4555.3 4564.2 4598.8 4816.8 4860.3 4878.6 4908.7 4910.8 5230.5 5232.0 5235.3 5249.2 5263.7 5040.6 5067.9 5271.4 5282.4 5300.0 4815.7 4844.1 4858.7 4865.9 4893.9 5339.2 5348.9 5352.3 5367.4 5398.4 5012.0 5102.4 5135.5 5150.5 5165.8 5105.5 5205.7 5280.2 5296.1 5331.9 5119.4 5122.4 5176.0 5205.6 5220.7 5009.7 5174.6 5176.0 5179.5 5235.5 4365.0 4405.5 4426.2 4434.8 4452.8 3845.8 3864.9 3869.5 3899.5 3910.6 4477.5 4550.6 4616.8 4624.9 4672.8 5291.8 5352.8 5353.5 5385.1 5409.9 4545.3 4604.4 4604.6 4625.2 4647.6 4576.5 4698.4 4746.2 4747.3 4810.8 4929.1 4951.0 4955.3 4967.7 4994.4 5288.9 5323.8 5329.0 5333.4 5367.4 4818.5 4844.8 4878.6 4900.5 4969.5 5120.2 5122.1 5124.1 5144.3 5194.2 5186.4 5190.3 5192.9 5230.2 5235.2 4952.4 4963.4 5094.9 5108.0 5144.4 4980.7 5039.7 5080.3 5084.3 5096.3 4995.4 5044.2 5046.2 5056.9 5070.4 5030.3 5087.2 5126.7 5138.5 5163.4 5013.9 5036.4 5041.9 5064.3 5106.3 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#1] ext.html Cycles:180 Average:46390.83 Median:184084.36 stddev:81335.60 (44.2%) stddev-sans-first:81490.89 15:20:54 INFO - PROCESS | 2308 | Values: 530.9 578.1 586.5 604.2 609.6 35844.5 39205.6 39316.8 39474.2 39490.8 39326.6 39861.8 40125.6 40136.6 40170.2 7781.5 7904.5 7906.8 7921.3 7927.2 7693.8 7843.3 7857.8 7869.3 7873.1 7885.0 7889.9 7922.4 7925.4 7928.3 7833.3 7843.2 7873.0 7892.1 7907.3 7783.5 7836.7 7874.9 7882.0 7889.7 37731.0 37861.0 38059.2 38196.2 38219.8 3250.9 3316.2 3461.7 3649.7 3860.2 29117.4 29286.3 29438.0 29576.0 29719.4 3013.2 3188.2 3191.5 3192.1 3195.3 259040.0 259046.0 260992.0 261395.7 262636.0 52620.5 52768.0 53222.5 53304.9 53341.2 54788.7 55056.0 55261.7 55287.7 55388.0 14769.6 14855.2 14885.3 14891.9 14991.2 11855.9 12030.6 12051.0 12077.7 12159.6 14030.2 15634.8 15721.2 15868.5 15942.1 5798.4 6116.6 6153.6 6158.9 6244.1 823.0 884.7 899.4 905.5 984.9 27913.6 28151.3 28364.6 28755.3 28888.3 960.7 965.5 1010.2 1051.4 1104.9 14249.1 14404.1 14531.4 14606.9 14712.6 364265.0 364519.0 367331.0 371002.0 372586.0 50644.5 50725.5 50874.0 51031.0 51101.0 1119.4 1199.5 1231.9 1232.5 1240.9 27371.6 28408.4 28857.3 29102.3 29258.4 41481.2 41638.4 42041.0 42108.4 42271.6 289362.0 290067.0 290550.0 291253.0 292342.0 23665.2 24978.0 25061.9 25091.9 25103.5 41076.6 41147.2 42101.8 42730.6 43134.1 35617.8 35805.5 36300.8 36397.8 36568.3 35063.6 35649.0 35781.5 35949.2 36111.6 35576.6 35891.8 35982.3 37450.0 37507.2 31491.0 32880.7 33584.7 33628.7 33662.7 25381.9 25865.0 25888.5 25941.0 26382.6 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#2] jquery.html Cycles:180 Average:24743.65 Median:413607.00 stddev:60233.06 (14.6%) stddev-sans-first:60374.23 15:20:54 INFO - PROCESS | 2308 | Values: 371.5 371.6 373.8 388.5 394.6 10401.2 10897.9 10957.7 10976.5 16072.7 17423.2 17577.7 18355.4 19239.0 19239.2 5466.9 5497.4 5678.6 5795.1 5795.2 4045.2 5626.3 6440.8 6833.1 6835.5 6228.2 6922.7 6937.6 6944.4 6947.1 6680.9 6749.5 6806.0 6846.4 6855.1 6695.5 6766.2 6826.1 6830.1 6857.9 21585.4 22288.8 23524.8 23711.2 23856.6 2101.3 2110.6 2160.3 2164.4 2208.3 13639.3 14304.5 14701.0 14785.1 14820.6 1821.9 1824.1 1848.6 1889.5 1945.1 78052.0 80353.6 81509.6 82153.2 84925.0 15639.9 16479.3 16650.8 17217.9 17760.1 28698.4 28881.6 29232.0 29307.1 29457.3 8847.9 9148.2 9159.9 9282.7 9471.8 7602.7 7671.4 7731.0 7764.8 7818.5 8044.6 8166.5 8315.0 8455.5 8530.9 1505.2 1573.7 1617.6 1638.8 1646.3 909.6 922.9 951.5 962.2 980.3 16402.5 16697.5 16737.7 16756.8 17118.2 868.9 877.8 885.8 895.4 947.8 9183.1 9553.1 9587.8 9720.1 9856.9 258480.0 265814.0 413559.0 413655.0 417495.0 80656.0 80939.6 81390.0 84735.2 85067.0 911.3 950.2 958.9 998.0 1000.8 12666.8 14598.2 15897.2 15920.6 16334.6 29879.6 35623.1 36817.0 37635.2 38502.0 44561.3 47278.5 47433.8 48192.3 54289.5 7407.2 7600.9 7813.6 7816.2 7932.4 8829.5 9789.6 11512.7 11721.9 11809.8 9922.1 10123.9 10187.6 10543.3 10594.4 10326.7 10704.5 10749.9 10753.5 10832.6 10555.3 10585.8 10817.9 10905.9 11038.2 7934.6 7941.8 7959.3 7976.3 7992.1 7986.2 10078.8 10381.5 10432.6 10692.3 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#3] mootools.html Cycles:180 Average:5069.70 Median:4822.93 stddev:2833.30 (58.7%) stddev-sans-first:2827.46 15:20:54 INFO - PROCESS | 2308 | Values: 1349.2 1380.0 1449.9 1621.5 1632.1 6701.0 7344.6 7437.8 7805.5 7839.1 7468.5 7721.4 7787.5 7795.0 7826.1 2199.6 2248.7 2250.7 2257.7 2260.6 2236.8 2248.0 2268.9 2270.9 2281.7 2196.6 2222.2 2224.2 2246.3 2254.2 2097.9 2101.7 2121.2 2132.8 2183.3 2194.1 2219.5 2224.8 2228.0 2229.6 7822.5 7858.3 7881.9 7884.0 7912.6 4537.4 4657.8 4668.5 4676.9 4682.8 2858.6 3007.8 3036.1 3078.6 3093.1 948.4 966.0 984.9 1619.8 1637.5 10444.5 10470.4 10525.4 10545.3 10576.4 4050.5 4104.9 4161.3 4193.6 4201.4 8340.1 8355.2 8362.5 8365.0 8382.0 4446.0 4463.4 4503.8 4505.5 4509.0 3519.5 4180.8 4194.9 4243.0 4345.0 3478.4 3509.8 3583.2 3620.2 3620.8 1042.6 1073.7 1080.5 1095.6 1104.8 675.3 713.3 785.2 795.3 807.4 4896.3 5079.4 5104.3 5145.4 5253.5 410.1 410.4 414.5 415.9 422.3 3353.3 3494.9 3507.5 3517.9 3530.3 9235.7 9643.5 9644.2 9746.0 9775.8 9561.6 9642.6 9646.4 9649.7 9699.5 6801.1 7093.0 7176.0 7338.1 7348.1 5060.9 5154.3 5257.9 5339.8 5344.8 8739.7 8848.6 8981.4 9009.1 9047.0 8853.2 9068.1 9080.4 9104.1 9107.0 6025.5 6529.2 6740.7 6777.4 6913.8 7519.5 7535.4 7555.5 7568.7 7588.9 6316.6 6320.2 6374.2 6510.1 6644.4 6074.2 6195.7 6253.0 6316.6 6407.3 6170.4 6245.2 6280.3 6287.5 6289.1 4587.9 4690.7 4733.8 4808.1 4837.8 4596.9 4612.7 4626.4 4637.1 4673.3 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#4] prototype.html Cycles:180 Average:4391.65 Median:5045.58 stddev:1283.36 (25.4%) stddev-sans-first:1249.70 15:20:54 INFO - PROCESS | 2308 | Values: 301.4 303.4 311.1 311.5 315.4 5090.1 5094.5 5112.2 5135.3 5175.1 5012.6 5014.5 5017.3 5019.4 5025.2 3742.7 3872.0 3953.4 3960.4 3970.8 3982.6 3985.9 3993.5 4005.7 4015.8 3957.9 3976.5 3981.9 3990.6 3991.6 3688.9 3919.2 3924.0 3967.0 3968.3 3382.4 3390.9 3397.9 3408.0 3416.9 4919.0 4939.0 4945.0 4946.9 4969.3 4172.8 4450.4 4478.2 4487.8 4532.9 5299.3 5308.9 5326.7 5351.9 5352.9 3782.1 3783.4 3786.7 3797.3 3798.3 5362.9 5570.4 5595.9 5605.0 5630.7 3831.3 3844.0 3846.4 3850.4 3860.2 3887.8 3900.4 3904.9 3908.3 3918.2 4465.4 4475.5 4485.7 4487.9 4500.5 5169.9 5273.7 5279.8 5281.6 5417.7 1319.9 1333.7 1336.2 1342.3 1346.9 820.3 841.4 842.8 849.2 850.2 4636.8 4639.9 4641.1 4645.4 4675.5 5397.2 5418.2 5450.6 5466.5 5487.6 4503.3 4630.8 4662.7 4664.4 4684.9 2892.7 2895.5 2901.8 2914.8 2922.2 5063.8 5095.2 5107.7 5124.6 5132.2 5406.7 5475.9 5553.9 5590.1 5596.7 5067.3 5118.7 5135.8 5160.4 5167.8 5389.9 5454.1 5464.9 5476.4 5539.2 5040.8 5261.9 5326.7 5343.5 5365.5 5084.3 5090.9 5121.2 5142.0 5149.5 3833.2 3835.3 3844.3 3857.4 3859.5 5327.3 5383.3 5431.6 5438.2 5473.1 5312.8 5329.6 5336.3 5336.5 5375.3 5050.3 5283.5 5304.9 5318.6 5376.4 5159.3 5166.3 5168.9 5170.7 5185.9 5084.6 5207.2 5342.6 5360.7 5400.8 5170.9 5200.1 5201.3 5213.5 5227.8 15:20:54 INFO - PROCESS | 2308 | 15:20:54 INFO - PROCESS | 2308 | [#5] yui.html Cycles:180 Average:17962.94 Median:498.90 stddev:26330.80 (5277.7%) stddev-sans-first:26372.59 15:20:54 INFO - PROCESS | 2308 | Values: 654.6 688.9 696.7 722.6 745.5 12440.5 13335.8 13545.3 13551.2 13584.4 11419.0 11687.7 11763.8 11782.8 11790.9 605.5 760.5 779.4 789.5 791.2 789.0 793.4 793.6 796.3 801.9 837.0 842.4 845.4 845.7 845.9 835.8 836.1 838.7 839.0 839.1 607.6 608.4 609.2 609.3 610.1 13625.9 13808.0 13815.6 13823.5 13866.8 13623.7 13748.0 13825.6 13837.7 13925.9 10827.9 10902.2 11138.3 11141.9 11295.5 3371.5 3397.7 3399.6 3437.1 3439.6 61997.4 62427.4 64510.7 64786.0 64865.7 10576.5 10702.6 10785.3 10785.4 10870.4 20163.7 20300.6 20354.9 20738.7 20957.2 7024.3 7070.2 7080.2 7095.1 7172.6 3811.8 3879.5 3912.7 3935.6 3942.7 2907.3 3021.5 3023.0 3029.9 3031.4 491.4 506.4 506.6 510.0 510.1 491.2 565.1 568.6 577.1 579.3 7237.7 7614.5 7803.6 7863.6 8254.8 480.8 548.6 564.4 580.4 598.6 3421.7 3570.9 3585.7 3654.0 3713.6 99479.0 100747.5 104934.5 105075.0 106900.5 54542.0 63759.4 84934.6 88796.2 89614.6 61290.0 83414.6 83781.0 83908.6 84690.6 6790.9 6972.9 6993.1 7049.5 7244.1 42264.4 46283.3 46579.4 46663.3 46869.8 66808.7 69725.0 70216.6 70533.0 70727.6 10139.7 10324.9 10474.6 10487.1 10559.7 11119.0 11164.9 11198.3 11316.2 12135.5 9904.2 10284.4 10362.2 10372.8 10715.9 10786.9 11240.8 11248.2 11265.5 11507.0 10065.2 10552.1 10819.9 10900.7 11023.8 8415.7 8505.2 8607.3 8731.1 9112.3 8786.8 8919.8 8988.1 9049.6 9283.8 15:20:54 INFO - PROCESS | 2308 | -------- Summary: end -------- 15:20:54 INFO - PROCESS | 2308 | 15:20:55 INFO - TEST-INFO | 2308: exit 0 15:20:55 INFO - TEST-OK | dromaeo_css | took 1117276ms 15:20:55 INFO - TEST-START | kraken 15:20:55 INFO - operating with platform_type : linux_ 15:20:55 INFO - Initialising browser for kraken test... 15:20:55 INFO - TEST-INFO | started process 2638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3LBR0B/profile http://localhost:47227/getInfo.html) 15:21:00 INFO - PROCESS | 2638 | __metrics Screen width/height:1600/1200 15:21:00 INFO - PROCESS | 2638 | colorDepth:24 15:21:00 INFO - PROCESS | 2638 | Browser inner width/height: 1024/697 15:21:00 INFO - PROCESS | 2638 | __metrics 15:21:01 ERROR - PROCESS | 2638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 15:21:01 INFO - TEST-INFO | 2638: exit 0 15:21:01 INFO - Browser initialized. 15:21:01 INFO - Running cycle 1/1 for kraken test... 15:21:01 INFO - TEST-INFO | started process 2823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3LBR0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:14 INFO - PROCESS | 2823 | RSS: Main: 186241024 15:21:14 INFO - PROCESS | 2823 | 15:21:16 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47227/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:17 INFO - PROCESS | 2823 | RSS: Main: 190353408 15:21:17 INFO - PROCESS | 2823 | 15:21:20 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47227/tests/kraken/driver.html?testName=audio-dft) 15:21:21 INFO - PROCESS | 2823 | RSS: Main: 190201856 15:21:21 INFO - PROCESS | 2823 | 15:21:24 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47227/tests/kraken/driver.html?testName=audio-fft) 15:21:24 INFO - PROCESS | 2823 | RSS: Main: 186015744 15:21:24 INFO - PROCESS | 2823 | 15:21:26 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47227/tests/kraken/driver.html?testName=audio-oscillator) 15:21:27 INFO - PROCESS | 2823 | RSS: Main: 186769408 15:21:27 INFO - PROCESS | 2823 | 15:21:29 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47227/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:30 INFO - PROCESS | 2823 | RSS: Main: 186843136 15:21:30 INFO - PROCESS | 2823 | 15:21:33 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47227/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:34 INFO - PROCESS | 2823 | RSS: Main: 187289600 15:21:34 INFO - PROCESS | 2823 | 15:21:37 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47227/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:38 INFO - PROCESS | 2823 | RSS: Main: 184451072 15:21:38 INFO - PROCESS | 2823 | 15:21:41 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47227/tests/kraken/driver.html?testName=json-parse-financial) 15:21:41 INFO - PROCESS | 2823 | RSS: Main: 185892864 15:21:41 INFO - PROCESS | 2823 | 15:21:43 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47227/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:44 INFO - PROCESS | 2823 | RSS: Main: 186109952 15:21:44 INFO - PROCESS | 2823 | 15:21:46 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:46 INFO - PROCESS | 2823 | RSS: Main: 186195968 15:21:46 INFO - PROCESS | 2823 | 15:21:48 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:49 INFO - PROCESS | 2823 | RSS: Main: 187219968 15:21:49 INFO - PROCESS | 2823 | 15:21:52 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:53 INFO - PROCESS | 2823 | RSS: Main: 187408384 15:21:53 INFO - PROCESS | 2823 | 15:21:56 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:56 INFO - PROCESS | 2823 | RSS: Main: 186765312 15:21:56 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | Cycle 1(1): loaded http://localhost:47227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47227/tests/kraken/driver.html?testName=ai-astar) 15:21:58 INFO - PROCESS | 2823 | RSS: Main: 187891712 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | __start_tp_report 15:21:58 INFO - PROCESS | 2823 | _x_x_mozilla_page_load 15:21:58 INFO - PROCESS | 2823 | _x_x_mozilla_page_load_details 15:21:58 INFO - PROCESS | 2823 | |i|pagename|runs| 15:21:58 INFO - PROCESS | 2823 | |0;ai-astar;105;113;108;118;116;116;117;113;113;114 15:21:58 INFO - PROCESS | 2823 | |1;audio-beat-detection;167;131;162;183;136;166;156;132;188;133 15:21:58 INFO - PROCESS | 2823 | |2;audio-dft;162;174;170;167;163;163;163;163;163;163 15:21:58 INFO - PROCESS | 2823 | |3;audio-fft;77;76;76;158;76;75;76;75;169;80 15:21:58 INFO - PROCESS | 2823 | |4;audio-oscillator;87;86;156;87;86;87;134;88;88;133 15:21:58 INFO - PROCESS | 2823 | |5;imaging-gaussian-blur;117;119;117;119;118;118;118;119;121;119 15:21:58 INFO - PROCESS | 2823 | |6;imaging-darkroom;148;148;148;147;148;149;147;147;147;148 15:21:58 INFO - PROCESS | 2823 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 15:21:58 INFO - PROCESS | 2823 | |8;json-parse-financial;66;65;64;64;63;63;64;66;64;65 15:21:58 INFO - PROCESS | 2823 | |9;json-stringify-tinderbox;65;65;65;66;66;65;67;65;65;65 15:21:58 INFO - PROCESS | 2823 | |10;stanford-crypto-aes;86;83;82;83;83;83;85;90;95;83 15:21:58 INFO - PROCESS | 2823 | |11;stanford-crypto-ccm;148;131;140;130;143;128;130;134;136;131 15:21:58 INFO - PROCESS | 2823 | |12;stanford-crypto-pbkdf2;171;171;169;170;168;168;172;170;170;170 15:21:58 INFO - PROCESS | 2823 | |13;stanford-crypto-sha256-iterative;72;67;71;71;68;69;67;68;67;70 15:21:58 INFO - PROCESS | 2823 | __end_tp_report 15:21:58 INFO - PROCESS | 2823 | __start_cc_report 15:21:58 INFO - PROCESS | 2823 | _x_x_mozilla_cycle_collect,985 15:21:58 INFO - PROCESS | 2823 | __end_cc_report 15:21:58 INFO - PROCESS | 2823 | __startTimestamp1466806918665__endTimestamp 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | ------- Summary: start ------- 15:21:58 INFO - PROCESS | 2823 | Number of tests: 14 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#0] ai-astar Cycles:10 Average:113.30 Median:115.00 stddev:4.06 (3.5%) stddev-sans-first:2.99 15:21:58 INFO - PROCESS | 2823 | Values: 105.0 113.0 108.0 118.0 116.0 116.0 117.0 113.0 113.0 114.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:164.00 stddev:21.44 (13.1%) stddev-sans-first:22.32 15:21:58 INFO - PROCESS | 2823 | Values: 167.0 131.0 162.0 183.0 136.0 166.0 156.0 132.0 188.0 133.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#2] audio-dft Cycles:10 Average:165.10 Median:163.00 stddev:3.98 (2.4%) stddev-sans-first:4.07 15:21:58 INFO - PROCESS | 2823 | Values: 162.0 174.0 170.0 167.0 163.0 163.0 163.0 163.0 163.0 163.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:36.85 (48.5%) stddev-sans-first:38.58 15:21:58 INFO - PROCESS | 2823 | Values: 77.0 76.0 76.0 158.0 76.0 75.0 76.0 75.0 169.0 80.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:87.00 stddev:26.80 (30.8%) stddev-sans-first:27.78 15:21:58 INFO - PROCESS | 2823 | Values: 87.0 86.0 156.0 87.0 86.0 87.0 134.0 88.0 88.0 133.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.18 (1.0%) stddev-sans-first:1.12 15:21:58 INFO - PROCESS | 2823 | Values: 117.0 119.0 117.0 119.0 118.0 118.0 118.0 119.0 121.0 119.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:21:58 INFO - PROCESS | 2823 | Values: 148.0 148.0 148.0 147.0 148.0 149.0 147.0 147.0 147.0 148.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 15:21:58 INFO - PROCESS | 2823 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:0.97 15:21:58 INFO - PROCESS | 2823 | Values: 66.0 65.0 64.0 64.0 63.0 63.0 64.0 66.0 64.0 65.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 15:21:58 INFO - PROCESS | 2823 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 67.0 65.0 65.0 65.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:4.14 (4.9%) stddev-sans-first:4.38 15:21:58 INFO - PROCESS | 2823 | Values: 86.0 83.0 82.0 83.0 83.0 83.0 85.0 90.0 95.0 83.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:135.00 stddev:6.59 (4.9%) stddev-sans-first:5.07 15:21:58 INFO - PROCESS | 2823 | Values: 148.0 131.0 140.0 130.0 143.0 128.0 130.0 134.0 136.0 131.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 15:21:58 INFO - PROCESS | 2823 | Values: 171.0 171.0 169.0 170.0 168.0 168.0 172.0 170.0 170.0 170.0 15:21:58 INFO - PROCESS | 2823 | 15:21:58 INFO - PROCESS | 2823 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.89 (2.7%) stddev-sans-first:1.66 15:21:58 INFO - PROCESS | 2823 | Values: 72.0 67.0 71.0 71.0 68.0 69.0 67.0 68.0 67.0 70.0 15:21:58 INFO - PROCESS | 2823 | -------- Summary: end -------- 15:21:58 INFO - PROCESS | 2823 | 15:21:59 INFO - TEST-INFO | 2823: exit 0 15:21:59 INFO - TEST-OK | kraken | took 64459ms 15:21:59 INFO - SUITE-END | took 1181s 15:21:59 INFO - Completed test suite (00:19:41) 15:21:59 INFO - javascript benchmark 15:21:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6558.486574346807, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.1837639519945, 2724.359775452768, 2733.5489644208706, 2742.2595899107255, 2745.0, 4850.175470170071, 4866.051120031595, 4899.755012249391, 4975.427825800034, 5008.273800298964, 4808.422989241287, 4833.32333473314, 4919.311296418504, 4955.083309587729, 4961.305417241589, 4381.802818873159, 4402.515723270446, 4449.221386257408, 4528.230200865861, 4530.22986092365, 4190.7485550866895, 4479.932801007987, 4514.04285849522, 4518.97740511297, 4579.038401935598, 4419.226635338803, 4450.221211288044, 4476.082403107355, 4498.910021799546, 4544.091181763644, 4482.327650852366, 4509.301058335963, 4574.382458368111, 4576.8626941191815, 4603.0, 4509.932351014738, 4521.389612402317, 4555.339475775994, 4564.201264778683, 4598.816047358102, 4816.831410900601, 4860.343853579757, 4878.609711223094, 4908.680935739166, 4910.828121015783, 5230.503102205284, 5231.973840130813, 5235.319408476912, 5249.212618107276, 5263.657862238981, 5040.571551418134, 5067.87330316745, 5271.367435907678, 5282.445343238943, 5300.0, 4815.686980346301, 4844.128056949748, 4858.659893807399, 4865.9026819464125, 4893.926591101136, 5339.172428273624, 5348.893022139536, 5352.304200453916, 5367.35591728995, 5398.406175320712, 5011.974940125276, 5102.36220472441, 5135.537801597874, 5150.459201783834, 5165.767540460688, 5105.5149760772665, 5205.687658740488, 5280.1815718563685, 5296.126139186991, 5331.946680533222, 5119.385673719103, 5122.359705036871, 5176.042432150064, 5205.609579281569, 5220.686758794484, 5009.7495125243595, 5174.560162386239, 5176.0, 5179.456157103526, 5235.502627250406, 4364.978175109104, 4405.515393306734, 4426.15902978433, 4434.84478043267, 4452.755098469551, 3845.788481633481, 3864.942025869614, 3869.4582758413844, 3899.512560929884, 3910.648041676263, 4477.485089214717, 4550.567696068868, 4616.76916154191, 4624.884377890579, 4672.76636168197, 5291.76187071575, 5352.785888564492, 5353.544948679406, 5385.057614917374, 5409.891802164014, 4545.250033744395, 4604.424446944132, 4604.58558729716, 4625.236835922035, 4647.581717645428, 4576.519465456146, 4698.389209402824, 4746.1931471649905, 4747.335373047776, 4810.7835147418455, 4929.06347793918, 4950.975245123751, 4955.331030310862, 4967.677100988352, 4994.375703037121, 5288.920666189933, 5323.813666521653, 5328.973355133199, 5333.359996800409, 5367.3827509836865, 4818.542238487338, 4844.8304309349005, 4878.56092951636, 4900.534449227318, 4969.453360130455, 5120.18077107661, 5122.052420302256, 5124.052050370693, 5144.254083157846, 5194.194899790538, 5186.429492755869, 5190.273361729436, 5192.948070519246, 5230.241614965885, 5235.188545775411, 4952.4057113146655, 4963.429205641253, 5094.872628184325, 5107.974460127824, 5144.356955380577, 4980.726060066731, 5039.748012599429, 5080.26336181259, 5084.2881996521255, 5096.286519887145, 4995.400551933792, 5044.243363495505, 5046.21783623539, 5056.924146137737, 5070.391553013662, 5030.295758593873, 5087.186050231945, 5126.6923984561045, 5138.511841375063, 5163.406208285945, 5013.949860501349, 5036.420811606712, 5041.899162016813, 5064.290999260033, 5106.259592359162], "value": 4805.039837303777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.8823321037394, 578.1385735254471, 586.4575267877212, 604.1572007050164, 609.6372658268328, 35844.46233306499, 39205.60794392055, 39316.80341598288, 39474.210515789666, 39490.802545987266, 39326.606733932655, 39861.80069099658, 40125.598744012554, 40136.59863401365, 40170.19659606806, 7781.494202876823, 7904.4862083964645, 7906.762797116067, 7921.287084162424, 7927.1676473970265, 7693.846123077535, 7843.294103530681, 7857.764267071997, 7869.252421020023, 7873.055233372003, 7884.960575197116, 7889.8816517752275, 7922.445428819985, 7925.445218834684, 7928.286454219119, 7833.334166595818, 7843.176466471024, 7873.0, 7892.092409372938, 7907.327877130451, 7783.455158138932, 7836.686532538692, 7874.881876771853, 7881.960590197013, 7889.684412623488, 37731.0, 37861.0, 38059.23881522354, 38196.236075278335, 38219.8089009556, 3250.8862189823244, 3316.219927168511, 3461.6538346165435, 3649.7262705296944, 3860.1700634363747, 29117.417651646847, 29286.267843303875, 29438.0, 29576.0, 29719.40561188764, 3013.171377871081, 3188.2348236423322, 3191.505316675919, 3192.058342788883, 3195.265089029513, 259040.0, 259046.0, 260992.0, 261395.69302153558, 262636.0, 52620.473795262325, 52768.0, 53222.467775321755, 53304.86780528813, 53341.1992920639, 54788.72605637026, 55056.0, 55261.72369138209, 55287.723561381936, 55388.0, 14769.63075923089, 14855.182964937032, 14885.255737213096, 14891.925540372446, 14991.17548534841, 11855.881441185478, 12030.63908082759, 12051.035917126608, 12077.698057548632, 12159.574414895436, 14030.228337441335, 15634.843651563338, 15721.213939302988, 15868.52394428169, 15942.123183224801, 5798.362180160179, 6116.602420842631, 6153.569250152446, 6158.907616385758, 6244.094606282155, 822.9547374894438, 884.7127429589931, 899.3524662243175, 905.4702998745807, 984.8621193032981, 27913.581296280572, 28151.296217594314, 28364.574531382044, 28755.2811179718, 28888.27779305492, 960.711786464058, 965.5124162297994, 1010.1716592394313, 1051.4059556350637, 1104.9060829829393, 14249.073810202512, 14404.135751854923, 14531.418743250362, 14606.85393146055, 14712.55862324132, 364265.0, 364519.0, 367331.0, 371002.0, 372586.0, 50644.49355506471, 50725.492745072814, 50874.0, 51031.0, 51101.0, 1119.367557330106, 1199.4542483170137, 1231.9076069294838, 1232.4700378837006, 1240.8883200511998, 27371.589426158225, 28408.431831362843, 28857.278568035126, 29102.27244318909, 29258.414831703674, 41481.170376592905, 41638.37542436927, 42041.0, 42108.368374473794, 42271.57728422676, 289362.0, 290067.0, 290550.0, 291253.0, 292342.0, 23665.171718989754, 24978.0, 25061.87469062643, 25091.87454062718, 25103.493790372635, 41076.589234107276, 41147.1770564593, 42101.78949105235, 42730.572694273906, 43134.137317254106, 35617.82191089028, 35805.46291805677, 36300.81849590735, 36397.818010909774, 36568.26863462769, 35063.64936350604, 35649.0, 35781.46327805033, 35949.22533133983, 36111.63888361083, 35576.64423355733, 35891.820540897126, 35982.28035439329, 37450.0, 37507.24985500329, 31491.0, 32880.67119328776, 33584.66415335816, 33628.663713362555, 33662.66337336693, 25381.873090634428, 25865.0, 25888.482230355665, 25941.0, 26382.604260935717], "value": 17480.703917331957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.46509027001116, 371.6265153520711, 373.8429859459028, 388.4852570344294, 394.61919247925744, 10401.167906567476, 10897.945510272457, 10957.671269861898, 10976.451177441117, 16072.678546429079, 17423.215955282012, 17577.73633395497, 18355.449336519927, 19239.0, 19239.23043078275, 5466.890662186754, 5497.367802702691, 5678.630888992202, 5795.072788353864, 5795.1886735857015, 4045.231406032859, 5626.268585083933, 6440.806775796734, 6833.111695479581, 6835.487338449611, 6228.22147231596, 6922.723091076351, 6937.618430986294, 6944.444444444458, 6947.131608548932, 6680.933190668104, 6749.527533072687, 6805.965970170167, 6846.418054465352, 6855.1088358513325, 6695.497837662195, 6766.221884483249, 6826.146731658543, 6830.112085428863, 6857.897131543031, 21585.352439426842, 22288.777112228832, 23524.76475235243, 23711.1701090461, 23856.64215036776, 2101.2960658179527, 2110.5778844231063, 2160.25471212433, 2164.448065743241, 2208.293346129239, 13639.318034098256, 14304.499342523066, 14701.0, 14785.11289322644, 14820.555383338517, 1821.854251659864, 1824.1244202782607, 1848.6210326882956, 1889.4520589029164, 1945.1246938877562, 78052.0, 80353.59823200906, 81509.59245203737, 82153.17846821574, 84924.99999999939, 15639.921800390925, 16479.258433370527, 16650.83349166517, 17217.91391043037, 17760.111994400228, 28698.42603147967, 28881.56677649837, 29232.0, 29307.069293070523, 29457.263568410533, 8847.938247410351, 9148.222401095849, 9159.908400915905, 9282.72151835446, 9471.76320591977, 7602.7339043133225, 7671.424643151786, 7730.961345193238, 7764.844703105906, 7818.452708310478, 8044.597770111588, 8166.469179503313, 8315.0, 8455.492670439793, 8530.914690853013, 1505.1796770759963, 1573.732465480871, 1617.5713435939485, 1638.7787648667277, 1646.2756387189597, 909.5725009245645, 922.8800255966815, 951.4529145741227, 962.1581116523042, 980.2941881845203, 16402.507924762278, 16697.49907502777, 16737.665246694996, 16756.832431675528, 17118.229679664444, 868.9485722276116, 877.8024944387589, 885.8051228729669, 895.3956079646213, 947.8151760406655, 9183.127602877716, 9553.140217380469, 9587.760305992266, 9720.125188733047, 9856.852147217798, 258480.0, 265814.0, 413559.0, 413655.0, 417495.0, 80656.0, 80939.59530202429, 81390.0, 84735.15264847396, 85067.0, 911.334725650279, 950.2208189284859, 958.9136977672043, 997.9870431512021, 1000.7698229407132, 12666.809997849856, 14598.197099159648, 15897.205139742735, 15920.601984950006, 16334.591635209215, 29879.55180672248, 35623.10942226465, 36817.0, 37635.24729505449, 38502.0, 44561.331580025675, 47278.52721472879, 47433.76283118701, 48192.27711584259, 54289.45710542844, 7407.185209627044, 7600.923990760243, 7813.609319534115, 7816.179301173523, 7932.444728868923, 8829.514376709343, 9789.559469824018, 11512.654620361403, 11721.882781172078, 11809.822852657046, 9922.107010369102, 10123.898761012295, 10187.592496300065, 10543.31468454548, 10594.364338139736, 10326.741831454274, 10704.464776761286, 10749.946250268698, 10753.516091775733, 10832.620858269922, 10555.261131721012, 10585.788284234426, 10817.891821081688, 10905.890941090487, 11038.17213708991, 7934.56359900211, 7941.801454963672, 7959.283664470226, 7976.282134607914, 7992.080910695345, 7986.161453047579, 10078.8488172676, 10381.53283102247, 10432.58269669235, 10692.305000174963], "value": 9099.794130732605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.2174538767515, 1379.972400551989, 1449.869511743943, 1621.4892308922697, 1632.1023437109602, 6701.0, 7344.559326440417, 7437.814054648637, 7805.531668099904, 7839.0985036720795, 7468.51454655447, 7721.420893433001, 7787.532748035122, 7794.961025194866, 7826.1391246962785, 2199.626063569197, 2248.651459023854, 2250.707408036961, 2257.7064981552376, 2260.638297872341, 2236.7539570647295, 2248.022110381989, 2268.875211863347, 2270.8751018693965, 2281.6805647209403, 2196.615592271346, 2222.2333295013277, 2224.177054489841, 2246.3261021693506, 2254.1546919905036, 2097.937061888138, 2101.6637338025844, 2121.1939463004037, 2132.8400369972314, 2183.257692384589, 2194.133317339658, 2219.4562332228707, 2224.799768020886, 2227.955440891173, 2229.6321107017325, 7822.530648161129, 7858.332041776456, 7881.921180788233, 7883.960580197119, 7912.564808935506, 4537.3647689323525, 4657.813687452498, 4668.486466488684, 4676.906461870778, 4682.836100736458, 2858.571214317848, 3007.774416918718, 3036.05882176526, 3078.569000339954, 3093.056617731591, 948.4119845695644, 966.0050148347214, 984.9064338887795, 1619.7651340555672, 1637.4596383193518, 10444.529996150191, 10470.42412667303, 10525.421101839396, 10545.261831671785, 10576.36541807494, 4050.4531888194715, 4104.8768536943935, 4161.271777438997, 4193.580641935843, 4201.390798334285, 8340.124286949784, 8355.206255405727, 8362.498250105013, 8364.958175209207, 8382.0, 4446.044100518339, 4463.419755431773, 4503.797329120198, 4505.549445055533, 4508.977455112704, 3519.454484554898, 4180.790960452026, 4194.937075943863, 4242.978785106055, 4345.022369966732, 3478.443449048191, 3509.78941263525, 3583.1937813991644, 3620.2216523447587, 3620.7827530348263, 1042.588177669816, 1073.7154654016535, 1080.4651697409834, 1095.59462998691, 1104.8342748587777, 675.3111825937516, 713.3294702979183, 785.1677222144431, 795.3445175568602, 807.3702512040618, 4896.314515967767, 5079.390473143247, 5104.336436263262, 5145.434002259748, 5253.527182553512, 410.1202919737147, 410.43974974160056, 414.47154877531386, 415.93345064790094, 422.3327143113873, 3353.346097510962, 3494.9126271843406, 3507.4563442666426, 3517.8944631661093, 3530.276293359855, 9235.676751313671, 9643.469609171423, 9644.228461723185, 9745.951270243604, 9775.804483910424, 9561.569729362196, 9642.566084526214, 9646.372985755903, 9649.662261820802, 9699.51502424876, 6801.149856267966, 7092.964535177394, 7175.964120179366, 7338.119425668847, 7348.081489813773, 5060.8987820242655, 5154.252633368215, 5257.894842103213, 5339.7597108131, 5344.759485823225, 8739.650413983369, 8848.601812918305, 8981.416207946462, 9009.099090090938, 9047.0, 8853.15894989975, 9068.093190680878, 9080.364374493722, 9104.13510716481, 9107.0, 6025.457708806229, 6529.249136349381, 6740.730370785113, 6777.356151165632, 6913.827154320981, 7519.511231769918, 7535.434842386952, 7555.471117021756, 7568.735094271674, 7588.924110758821, 6316.589421687576, 6320.209973753281, 6374.235091789015, 6510.088587597835, 6644.368784965421, 6074.210352654127, 6195.659238741912, 6252.999520076766, 6316.557840951089, 6407.295197528175, 6170.352113028068, 6245.156903818108, 6280.27776805655, 6287.497000240061, 6289.056641503811, 4587.931181032221, 4690.742009189391, 4733.8343157990685, 4808.06242782654, 4837.806487740451, 4596.908061838678, 4612.74629895359, 4626.37543931565, 4637.072585482984, 4673.299005149255], "value": 4040.7302640307034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.4107419993911, 303.3811025507963, 311.11953172521766, 311.5498105237932, 315.43851943540506, 5090.134677104892, 5094.490550944908, 5112.207607820789, 5135.255387968742, 5175.1461008933575, 5012.571417146114, 5014.523620256079, 5017.322661440704, 5019.372578427697, 5025.2462130680415, 3742.681872040873, 3872.0319920019997, 3953.3674612062077, 3960.4455376247347, 3970.7617542947373, 3982.5818289079666, 3985.9437249129005, 3993.5008123984503, 4005.699572532057, 4015.759054456742, 3957.872006478154, 3976.5485597756756, 3981.86063487778, 3990.6009399060154, 3991.580884007181, 3688.9262214755554, 3919.2357490289405, 3923.9803800980812, 3966.9999999999854, 3968.285708572456, 3382.391169589473, 3390.8982730518123, 3397.8980630581123, 3408.0, 3416.8804091856914, 4919.0, 4938.950610493921, 4945.0, 4946.9010619787405, 4969.279454479117, 4172.812223449952, 4450.354698568722, 4478.193925093482, 4487.775611219426, 4532.8866778330475, 5299.258103865462, 5308.946910530923, 5326.680399176062, 5351.9296140772, 5352.946470535284, 3782.130110074698, 3783.4324851272254, 3786.678132358753, 3797.316483033053, 3798.3352913240074, 5362.865928351784, 5570.359408667974, 5595.916061259084, 5605.0, 5630.746616402272, 3831.272058308912, 3843.9807800961376, 3846.442265871489, 3850.383938569815, 3860.2279544091293, 3887.7667339959694, 3900.414937759359, 3904.9219015620097, 3908.257431088084, 3918.2163567286657, 4465.437097016018, 4475.507694153641, 4485.730856148642, 4487.887802804956, 4500.459944806644, 5169.948300516947, 5273.736313184326, 5279.805717540909, 5281.577473802086, 5417.702026388508, 1319.907606467538, 1333.6932505523785, 1336.245021562814, 1342.328835582209, 1346.8888167262048, 820.2822530285999, 841.3984001439001, 842.7527259655744, 849.180540778152, 850.2305413600701, 4636.768161591907, 4639.86080417588, 4641.071785642885, 4645.419322584677, 4675.485696573374, 5397.2443857859935, 5418.214358917935, 5450.618456707993, 5466.453354664502, 5487.5609951203805, 4503.279475283939, 4630.83792067276, 4662.650301227422, 4664.370310008173, 4684.859454216379, 2892.7107289270903, 2895.4932886744737, 2901.8113822601886, 2914.825110493377, 2922.167182353019, 5063.759378952181, 5095.159298715745, 5107.693538387709, 5124.56441202502, 5132.153194722903, 5406.675599464044, 5475.863103422366, 5553.944460555424, 5590.077637189899, 5596.720163991866, 5067.341245638044, 5118.74406279692, 5135.768890399941, 5160.354955630546, 5167.793288268427, 5389.919151212814, 5454.127339625641, 5464.945350546603, 5476.397596264487, 5539.169124631177, 5040.84877453677, 5261.921071183859, 5326.707031113326, 5343.492368225013, 5365.543928766098, 5084.288199651977, 5090.949090509195, 5121.231815227746, 5142.043325088164, 5149.510796474329, 3833.2333533292895, 3835.328817456878, 3844.2695887781233, 3857.363535016803, 3859.4982652255026, 5327.3074500314715, 5383.300170977748, 5431.56063643127, 5438.23864658956, 5473.124300111963, 5312.840614781563, 5329.57363410934, 5336.279602253646, 5336.546393556591, 5375.3280839895015, 5050.3182070420025, 5283.524482796567, 5304.920426193533, 5318.574514038945, 5376.435474275145, 5159.251908473326, 5166.2508936203285, 5168.870778230575, 5170.741462926763, 5185.9222111667605, 5084.6440749147205, 5207.192885102815, 5342.572594192377, 5360.70516121617, 5400.7569659364635, 5170.922436163385, 5200.089984252665, 5201.271821945006, 5213.478652134756, 5227.817026404057], "value": 3977.5616873979584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.6203202142758, 688.9379955803978, 696.6725638949695, 722.559238864293, 745.500514655181, 12440.502379904805, 13335.778506924125, 13545.322733863304, 13551.186928784267, 13584.388702508386, 11419.0, 11687.7078073048, 11763.823542646867, 11782.823257651142, 11790.882091179086, 605.4944121658399, 760.5132715062337, 779.3803925878925, 789.4552758596578, 791.2285521616407, 788.9566073865935, 793.3970182661161, 793.623029061197, 796.2992566541465, 801.8556659801234, 837.0374069819726, 842.4145219072716, 845.4166625028741, 845.6997765793147, 845.8773477845708, 835.7534527314426, 836.1262480707645, 838.739990602909, 838.995805020971, 839.1189251286125, 607.6232735703848, 608.4159207161131, 609.165443342619, 609.3236507476697, 610.0635524469917, 13625.863741362658, 13808.0, 13815.585532434043, 13823.51617693376, 13866.791998120036, 13623.727525449534, 13748.0, 13825.585232443043, 13837.723245535033, 13925.860741392658, 10827.891721082768, 10902.182336324808, 11138.27601205919, 11141.888581114166, 11295.49170287339, 3371.511130886008, 3397.711194548466, 3399.5920489541168, 3437.1407148212948, 3439.6044454887756, 61997.380026199615, 62427.37572624261, 64510.677446612935, 64786.0, 64865.67567162134, 10576.471176441148, 10702.571897124184, 10785.298955567863, 10785.406802625774, 10870.402127883042, 20163.697544536844, 20300.593988120156, 20354.89822550878, 20738.688919666216, 20957.161713531288, 7024.332688394697, 7070.186928503288, 7080.221175670672, 7095.113110861143, 7172.641367931687, 3811.8094095295123, 3879.534455865314, 3912.68698504119, 3935.626115519021, 3942.704297177666, 2907.2877145099164, 3021.4561378952, 3022.9848850755607, 3029.8636561354792, 3031.4088752693456, 491.40785353648766, 506.3973871093387, 506.6326912988128, 510.01312460389266, 510.0538501080516, 491.1968930798171, 565.0817421689754, 568.5650477384804, 577.1458241802072, 579.2787978966214, 7237.674304656303, 7614.466987310835, 7803.609819509002, 7863.646135923897, 8254.793630159174, 480.82690231516625, 548.5803360429275, 564.4214679953081, 580.3702982264291, 598.5809933046885, 3421.674940880612, 3570.910727231788, 3585.6772890439984, 3653.9817300913323, 3713.5729391119826, 99479.0, 100747.49626251968, 104934.47532762287, 105075.0, 106900.46549767202, 54542.0, 63759.362406375345, 84934.57532712296, 88796.23241443436, 89614.55192723994, 61290.0, 83414.58292708498, 83781.0, 83908.58045709733, 84690.57654711687, 6790.8641827164165, 6972.930270697431, 6993.055937448379, 7049.471289653194, 7244.058272424551, 42264.36603451012, 46283.305750414445, 46579.43813090177, 46663.30005049995, 46869.765651171525, 66808.66595666991, 69725.0, 70216.64891675509, 70533.0, 70727.64636176787, 10139.695809125738, 10324.896751032393, 10474.633387831389, 10487.115445014664, 10559.683209503728, 11118.953416704748, 11164.888351116384, 11198.272112312674, 11316.20786544934, 12135.514579416724, 9904.158146557624, 10284.382937023802, 10362.171026318027, 10372.844407334047, 10715.928407159221, 10786.946065269623, 11240.775184496428, 11248.212625116163, 11265.549378025114, 11507.021903138328, 10065.24510661718, 10552.103071239031, 10819.945900270448, 10900.672979810619, 11023.83464248021, 8415.663373464993, 8505.192006759347, 8607.309579858596, 8731.083236260101, 9112.316576256675, 8786.780330491789, 8919.777005574913, 8988.10118988096, 9049.638014479347, 9283.76790580241], "value": 6477.511671027966, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 108.0, 118.0, 116.0, 116.0, 117.0, 113.0, 113.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 162.0, 183.0, 136.0, 166.0, 156.0, 132.0, 188.0, 133.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 174.0, 170.0, 167.0, 163.0, 163.0, 163.0, 163.0, 163.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 158.0, 76.0, 75.0, 76.0, 75.0, 169.0, 80.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 156.0, 87.0, 86.0, 87.0, 134.0, 88.0, 88.0, 133.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 121.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.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": [66.0, 65.0, 64.0, 64.0, 63.0, 63.0, 64.0, 66.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 83.0, 83.0, 83.0, 85.0, 90.0, 95.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 140.0, 130.0, 143.0, 128.0, 130.0, 134.0, 136.0, 131.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 170.0, 168.0, 168.0, 172.0, 170.0, 170.0, 170.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 71.0, 71.0, 68.0, 69.0, 67.0, 68.0, 67.0, 70.0], "value": 69.0, "unit": "score"}]}]} 15:21:59 INFO - Return code: 0 15:21:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:59 ERROR - # TBPL SUCCESS # 15:21:59 INFO - Running post-action listener: _resource_record_post_action 15:21:59 INFO - ##### 15:21:59 INFO - ##### Finished run-tests step (success) 15:21:59 INFO - ##### 15:21:59 INFO - Running post-run listener: _resource_record_post_run 15:22:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 309698560; Read time: 12; Write time: 277704 15:22:00 INFO - TinderboxPrint: CPU usage
13.4% 15:22:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12 15:22:00 INFO - TinderboxPrint: I/O write bytes / time
309,698,560 / 277,704 15:22:00 INFO - TinderboxPrint: CPU idle
8,278.5 (86.5%) 15:22:00 INFO - TinderboxPrint: CPU user
1,231.3 (12.9%) 15:22:00 INFO - TinderboxPrint: Swap in / out
0 / 0 15:22:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13889536; Read time: 0; Write time: 1816 15:22:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295809024; Read time: 12; Write time: 275888 15:22:00 INFO - Running post-run listener: _upload_blobber_files 15:22:00 INFO - Blob upload gear active. 15:22:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:22:00 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:22:00 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:22:01 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:01 INFO - (blobuploader) - INFO - Done attempting. 15:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:02 INFO - (blobuploader) - INFO - Done attempting. 15:22:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:05 INFO - (blobuploader) - INFO - Done attempting. 15:22:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:05 INFO - Return code: 0 15:22:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b5827f6b4dc53cf87f733605c195223495473c039e40db4a9218706f03dbe7393518f914a2a7f4e5deeb897a254d7ba8c9b799497edf657458d9bdec22a1cd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e941e559eeac1b93c9bc7fcc1948f173d1e3121fc77d8c51d388e63d18110558b8a68c37ee8cf24a2d39b257a9629a114c4592c290f0075cbf69149c814e26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2acc9f0bb279b8ef632c8c0687aa0792e7979e00cd47e1e2b25a92f0d9cc57468fc6f75f1bffcfbf5abf4b015921282ac2b588018d5933aa98d8bfc835912430"} 15:22:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:05 INFO - Contents: 15:22:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b5827f6b4dc53cf87f733605c195223495473c039e40db4a9218706f03dbe7393518f914a2a7f4e5deeb897a254d7ba8c9b799497edf657458d9bdec22a1cd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e941e559eeac1b93c9bc7fcc1948f173d1e3121fc77d8c51d388e63d18110558b8a68c37ee8cf24a2d39b257a9629a114c4592c290f0075cbf69149c814e26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2acc9f0bb279b8ef632c8c0687aa0792e7979e00cd47e1e2b25a92f0d9cc57468fc6f75f1bffcfbf5abf4b015921282ac2b588018d5933aa98d8bfc835912430"} 15:22:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:05 INFO - Copying logs to upload dir... 15:22:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1719.622835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 39 secs) (at 2016-06-24 15:22:05.899735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:22:05.903016) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 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/Firefox-Non-PGO/sha512/5b5827f6b4dc53cf87f733605c195223495473c039e40db4a9218706f03dbe7393518f914a2a7f4e5deeb897a254d7ba8c9b799497edf657458d9bdec22a1cd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e941e559eeac1b93c9bc7fcc1948f173d1e3121fc77d8c51d388e63d18110558b8a68c37ee8cf24a2d39b257a9629a114c4592c290f0075cbf69149c814e26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2acc9f0bb279b8ef632c8c0687aa0792e7979e00cd47e1e2b25a92f0d9cc57468fc6f75f1bffcfbf5abf4b015921282ac2b588018d5933aa98d8bfc835912430"} build_url:https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011470 build_url: 'https://queue.taskcluster.net/v1/task/R7j3g-8pT6a2RH4RMcF06g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b5827f6b4dc53cf87f733605c195223495473c039e40db4a9218706f03dbe7393518f914a2a7f4e5deeb897a254d7ba8c9b799497edf657458d9bdec22a1cd2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e941e559eeac1b93c9bc7fcc1948f173d1e3121fc77d8c51d388e63d18110558b8a68c37ee8cf24a2d39b257a9629a114c4592c290f0075cbf69149c814e26a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2acc9f0bb279b8ef632c8c0687aa0792e7979e00cd47e1e2b25a92f0d9cc57468fc6f75f1bffcfbf5abf4b015921282ac2b588018d5933aa98d8bfc835912430"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:22:05.930953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:22:05.931569) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466805063.87113-1459483996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:22:06.015995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:22:06.016461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:22:06.016870) ========= ========= Total master_lag: 0.18 =========