builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1465411179.03 results: success (0) buildid: 20160608105728 builduid: c19c9497a23e4c09b584e3e589b76691 revision: 63ec66da50faad032454a44d3af3124c35102b3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.033236) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.033712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.034013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.065949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.066304) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 11:39:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.1M=0.001s 2016-06-08 11:39:39 (17.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.163185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.163550) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013904 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.218441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.219037) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63ec66da50faad032454a44d3af3124c35102b3e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 63ec66da50faad032454a44d3af3124c35102b3e --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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 11:39:39,292 truncating revision to first 12 chars 2016-06-08 11:39:39,293 Setting DEBUG logging. 2016-06-08 11:39:39,293 attempt 1/10 2016-06-08 11:39:39,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63ec66da50fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 11:39:39,607 unpacking tar archive at: fx-team-63ec66da50fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634947 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.886249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.886806) ========= script_repo_revision: 63ec66da50faad032454a44d3af3124c35102b3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.887513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.888041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 11:39:39.907653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 11:39:39.908136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:39:40 INFO - MultiFileLogger online at 20160608 11:39:40 in /builds/slave/test 11:39:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:39:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:39:40 INFO - {'append_to_log': False, 11:39:40 INFO - 'base_work_dir': '/builds/slave/test', 11:39:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:39:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:39:40 INFO - 'branch': 'Fx-Team-Non-PGO', 11:39:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:39:40 INFO - 'config_files': ('talos/linux_config.py',), 11:39:40 INFO - 'default_actions': ('clobber', 11:39:40 INFO - 'read-buildbot-config', 11:39:40 INFO - 'download-and-extract', 11:39:40 INFO - 'populate-webroot', 11:39:40 INFO - 'create-virtualenv', 11:39:40 INFO - 'install', 11:39:40 INFO - 'run-tests'), 11:39:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:39:40 INFO - 'download_minidump_stackwalk': True, 11:39:40 INFO - 'download_symbols': 'ondemand', 11:39:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:39:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:39:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:39:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:39:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:39:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:39:40 INFO - 'installer_path': 'installer.exe', 11:39:40 INFO - 'log_level': 'info', 11:39:40 INFO - 'log_name': 'talos', 11:39:40 INFO - 'log_to_console': True, 11:39:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:39:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:39:40 INFO - 'opt_config_files': (), 11:39:40 INFO - 'pip_index': False, 11:39:40 INFO - 'sps_profile': False, 11:39:40 INFO - 'sps_profile_interval': 0, 11:39:40 INFO - 'suite': 'dromaeojs-e10s', 11:39:40 INFO - 'system_bits': '32', 11:39:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:39:40 INFO - 'title': 'talos-linux64-ix-015', 11:39:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:39:40 INFO - 'use_talos_json': True, 11:39:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:39:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:39:40 INFO - 'work_dir': 'build'} 11:39:40 INFO - ##### 11:39:40 INFO - ##### Running clobber step. 11:39:40 INFO - ##### 11:39:40 INFO - Running pre-action listener: _resource_record_pre_action 11:39:40 INFO - Running main action method: clobber 11:39:40 INFO - rmtree: /builds/slave/test/build 11:39:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:39:40 INFO - Running post-action listener: _resource_record_post_action 11:39:40 INFO - ##### 11:39:40 INFO - ##### Finished clobber step (success) 11:39:40 INFO - ##### 11:39:40 INFO - ##### 11:39:40 INFO - ##### Running read-buildbot-config step. 11:39:40 INFO - ##### 11:39:40 INFO - Running pre-action listener: _resource_record_pre_action 11:39:40 INFO - Running main action method: read_buildbot_config 11:39:40 INFO - Using buildbot properties: 11:39:40 INFO - { 11:39:40 INFO - "project": "", 11:39:40 INFO - "product": "firefox", 11:39:40 INFO - "script_repo_revision": "production", 11:39:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:39:40 INFO - "repository": "", 11:39:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 11:39:40 INFO - "buildid": "20160608105728", 11:39:40 INFO - "pgo_build": "False", 11:39:40 INFO - "basedir": "/builds/slave/test", 11:39:40 INFO - "buildnumber": 1570, 11:39:40 INFO - "slavename": "talos-linux64-ix-015", 11:39:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:39:40 INFO - "platform": "ubuntu64_hw", 11:39:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:39:40 INFO - "branch": "fx-team", 11:39:40 INFO - "repo_path": "integration/fx-team", 11:39:40 INFO - "revision": "63ec66da50faad032454a44d3af3124c35102b3e", 11:39:40 INFO - "stage_platform": "linux64", 11:39:40 INFO - "builduid": "c19c9497a23e4c09b584e3e589b76691", 11:39:40 INFO - "slavebuilddir": "test" 11:39:40 INFO - } 11:39:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:39:40 INFO - Running post-action listener: _resource_record_post_action 11:39:40 INFO - ##### 11:39:40 INFO - ##### Finished read-buildbot-config step (success) 11:39:40 INFO - ##### 11:39:40 INFO - ##### 11:39:40 INFO - ##### Running download-and-extract step. 11:39:40 INFO - ##### 11:39:40 INFO - Running pre-action listener: _resource_record_pre_action 11:39:40 INFO - Running main action method: download_and_extract 11:39:40 INFO - mkdir: /builds/slave/test/build/tests 11:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:40 INFO - https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:42 INFO - Downloaded 1361 bytes. 11:39:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:39:42 INFO - Using the following test package requirements: 11:39:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:39:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:39:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:39:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'jsshell-linux-x86_64.zip'], 11:39:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:39:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:39:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:39:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:39:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:39:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:39:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:42 INFO - https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:43 INFO - Downloaded 22878253 bytes. 11:39:43 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'] 11:39:43 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 11:39:45 INFO - Return code: 0 11:39:45 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 11:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:45 INFO - https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:39:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:39:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:39:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:46 INFO - Downloaded 22878253 bytes. 11:39:46 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'] 11:39:46 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 11:39:47 INFO - Return code: 0 11:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:47 INFO - https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:49 INFO - Downloaded 10833369 bytes. 11:39:49 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'] 11:39:49 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 11:39:49 INFO - Return code: 0 11:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:49 INFO - https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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 11:39:51 INFO - Downloaded 55367496 bytes. 11:39:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:51 INFO - mkdir: /builds/slave/test/properties 11:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:51 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:51 INFO - Contents: 11:39:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:39:52 INFO - Running post-action listener: _resource_record_post_action 11:39:52 INFO - Running post-action listener: set_extra_try_arguments 11:39:52 INFO - ##### 11:39:52 INFO - ##### Finished download-and-extract step (success) 11:39:52 INFO - ##### 11:39:52 INFO - ##### 11:39:52 INFO - ##### Running populate-webroot step. 11:39:52 INFO - ##### 11:39:52 INFO - Running pre-action listener: _resource_record_pre_action 11:39:52 INFO - Running main action method: populate_webroot 11:39:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:52 INFO - '--tppagecycles', 11:39:52 INFO - '7'], 11:39:52 INFO - 'tests': ['tsvgm']}}, 11:39:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['damp', 'tps']}, 11:39:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'tests': ['damp', 'tps']}, 11:39:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['dromaeo_dom']}, 11:39:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['a11yr', 11:39:52 INFO - 'ts_paint', 11:39:52 INFO - 'tpaint', 11:39:52 INFO - 'sessionrestore', 11:39:52 INFO - 'sessionrestore_no_auto_restore', 11:39:52 INFO - 'tabpaint']}, 11:39:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['tsvgx', 11:39:52 INFO - 'tsvgr_opacity', 11:39:52 INFO - 'tart', 11:39:52 INFO - 'tscrollx', 11:39:52 INFO - 'cart']}, 11:39:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:52 INFO - 'tsvgr_opacity', 11:39:52 INFO - 'tart', 11:39:52 INFO - 'tscrollx', 11:39:52 INFO - 'cart']}, 11:39:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-e10s'], 11:39:52 INFO - 'tests': ['tp5o']}, 11:39:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'tests': ['tp5o']}, 11:39:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'talos_options': ['--disable-e10s', 11:39:52 INFO - '--xperf_path', 11:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:52 INFO - 'tests': ['tp5n']}, 11:39:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:52 INFO - 'talos_options': ['--xperf_path', 11:39:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:52 INFO - 'tests': ['tp5n']}}, 11:39:52 INFO - 'talos.zip': {'path': '', 11:39:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:52 INFO - Running post-action listener: _resource_record_post_action 11:39:52 INFO - ##### 11:39:52 INFO - ##### Finished populate-webroot step (success) 11:39:52 INFO - ##### 11:39:52 INFO - ##### 11:39:52 INFO - ##### Running create-virtualenv step. 11:39:52 INFO - ##### 11:39:52 INFO - Running pre-action listener: _resource_record_pre_action 11:39:52 INFO - Running main action method: create_virtualenv 11:39:52 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:39:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:52 INFO - Using real prefix '/usr' 11:39:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:55 INFO - Installing pip.................done. 11:39:55 INFO - Return code: 0 11:39:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:55 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:39:55 INFO - Using env: {'DISPLAY': ':0', 11:39:55 INFO - 'HOME': '/home/cltbld', 11:39:55 INFO - 'LANG': 'en_US.UTF-8', 11:39:55 INFO - 'LANGUAGE': 'en_US:en', 11:39:55 INFO - 'LOGNAME': 'cltbld', 11:39:55 INFO - 'MAIL': '/var/mail/cltbld', 11:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:55 INFO - 'MOZ_NO_REMOTE': '1', 11:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:55 INFO - 'NO_EM_RESTART': '1', 11:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:55 INFO - 'PWD': '/builds/slave/test', 11:39:55 INFO - 'SHELL': '/bin/bash', 11:39:55 INFO - 'SHLVL': '1', 11:39:55 INFO - 'TERM': 'linux', 11:39:55 INFO - 'TMOUT': '86400', 11:39:55 INFO - 'USER': 'cltbld', 11:39:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:55 INFO - '_': '/tools/buildbot/bin/python'} 11:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:39:55 INFO - Cleaning up... 11:39:55 INFO - Return code: 0 11:39:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:55 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:39:55 INFO - Using env: {'DISPLAY': ':0', 11:39:55 INFO - 'HOME': '/home/cltbld', 11:39:55 INFO - 'LANG': 'en_US.UTF-8', 11:39:55 INFO - 'LANGUAGE': 'en_US:en', 11:39:55 INFO - 'LOGNAME': 'cltbld', 11:39:55 INFO - 'MAIL': '/var/mail/cltbld', 11:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:55 INFO - 'MOZ_NO_REMOTE': '1', 11:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:55 INFO - 'NO_EM_RESTART': '1', 11:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:55 INFO - 'PWD': '/builds/slave/test', 11:39:55 INFO - 'SHELL': '/bin/bash', 11:39:55 INFO - 'SHLVL': '1', 11:39:55 INFO - 'TERM': 'linux', 11:39:55 INFO - 'TMOUT': '86400', 11:39:55 INFO - 'USER': 'cltbld', 11:39:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:55 INFO - '_': '/tools/buildbot/bin/python'} 11:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:55 INFO - Downloading/unpacking psutil>=3.1.1 11:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:57 INFO - Installing collected packages: psutil 11:39:57 INFO - Running setup.py install for psutil 11:39:57 INFO - building 'psutil._psutil_linux' extension 11:39:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:39:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:39:57 INFO - building 'psutil._psutil_posix' extension 11:39:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:39:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:39:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:58 INFO - Successfully installed psutil 11:39:58 INFO - Cleaning up... 11:39:58 INFO - Return code: 0 11:39:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:39:58 INFO - Using env: {'DISPLAY': ':0', 11:39:58 INFO - 'HOME': '/home/cltbld', 11:39:58 INFO - 'LANG': 'en_US.UTF-8', 11:39:58 INFO - 'LANGUAGE': 'en_US:en', 11:39:58 INFO - 'LOGNAME': 'cltbld', 11:39:58 INFO - 'MAIL': '/var/mail/cltbld', 11:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:58 INFO - 'MOZ_NO_REMOTE': '1', 11:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:58 INFO - 'NO_EM_RESTART': '1', 11:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:58 INFO - 'PWD': '/builds/slave/test', 11:39:58 INFO - 'SHELL': '/bin/bash', 11:39:58 INFO - 'SHLVL': '1', 11:39:58 INFO - 'TERM': 'linux', 11:39:58 INFO - 'TMOUT': '86400', 11:39:58 INFO - 'USER': 'cltbld', 11:39:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:58 INFO - '_': '/tools/buildbot/bin/python'} 11:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:40:00 INFO - Installing collected packages: mozsystemmonitor 11:40:00 INFO - Running setup.py install for mozsystemmonitor 11:40:01 INFO - Successfully installed mozsystemmonitor 11:40:01 INFO - Cleaning up... 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:40:01 INFO - Using env: {'DISPLAY': ':0', 11:40:01 INFO - 'HOME': '/home/cltbld', 11:40:01 INFO - 'LANG': 'en_US.UTF-8', 11:40:01 INFO - 'LANGUAGE': 'en_US:en', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MAIL': '/var/mail/cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SHLVL': '1', 11:40:01 INFO - 'TERM': 'linux', 11:40:01 INFO - 'TMOUT': '86400', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - '_': '/tools/buildbot/bin/python'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:03 INFO - warning: no files found matching '*.txt' 11:40:03 INFO - no previously-included directories found matching 'build' 11:40:03 INFO - no previously-included directories found matching 'dist' 11:40:03 INFO - no previously-included directories found matching '.git*' 11:40:03 INFO - Installing collected packages: jsonschema, functools32 11:40:03 INFO - Running setup.py install for functools32 11:40:03 INFO - warning: no files found matching '*.txt' 11:40:03 INFO - no previously-included directories found matching 'build' 11:40:03 INFO - no previously-included directories found matching 'dist' 11:40:03 INFO - no previously-included directories found matching '.git*' 11:40:03 INFO - Successfully installed jsonschema functools32 11:40:03 INFO - Cleaning up... 11:40:03 INFO - Return code: 0 11:40:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:03 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:40:03 INFO - Using env: {'DISPLAY': ':0', 11:40:03 INFO - 'HOME': '/home/cltbld', 11:40:03 INFO - 'LANG': 'en_US.UTF-8', 11:40:03 INFO - 'LANGUAGE': 'en_US:en', 11:40:03 INFO - 'LOGNAME': 'cltbld', 11:40:03 INFO - 'MAIL': '/var/mail/cltbld', 11:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:03 INFO - 'MOZ_NO_REMOTE': '1', 11:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:03 INFO - 'NO_EM_RESTART': '1', 11:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:03 INFO - 'PWD': '/builds/slave/test', 11:40:03 INFO - 'SHELL': '/bin/bash', 11:40:03 INFO - 'SHLVL': '1', 11:40:03 INFO - 'TERM': 'linux', 11:40:03 INFO - 'TMOUT': '86400', 11:40:03 INFO - 'USER': 'cltbld', 11:40:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:03 INFO - '_': '/tools/buildbot/bin/python'} 11:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:06 INFO - Downloading docopt-0.6.1.tar.gz 11:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:06 INFO - Running setup.py install for blobuploader 11:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:06 INFO - Running setup.py install for requests 11:40:07 INFO - Running setup.py install for docopt 11:40:07 INFO - Successfully installed blobuploader requests docopt 11:40:07 INFO - Cleaning up... 11:40:07 INFO - Return code: 0 11:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:07 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:40:07 INFO - Using env: {'DISPLAY': ':0', 11:40:07 INFO - 'HOME': '/home/cltbld', 11:40:07 INFO - 'LANG': 'en_US.UTF-8', 11:40:07 INFO - 'LANGUAGE': 'en_US:en', 11:40:07 INFO - 'LOGNAME': 'cltbld', 11:40:07 INFO - 'MAIL': '/var/mail/cltbld', 11:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:07 INFO - 'MOZ_NO_REMOTE': '1', 11:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:07 INFO - 'NO_EM_RESTART': '1', 11:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:07 INFO - 'PWD': '/builds/slave/test', 11:40:07 INFO - 'SHELL': '/bin/bash', 11:40:07 INFO - 'SHLVL': '1', 11:40:07 INFO - 'TERM': 'linux', 11:40:07 INFO - 'TMOUT': '86400', 11:40:07 INFO - 'USER': 'cltbld', 11:40:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:07 INFO - '_': '/tools/buildbot/bin/python'} 11:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:07 INFO - Running setup.py (path:/tmp/pip-vhaQ_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:07 INFO - Running setup.py (path:/tmp/pip-LUlME4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:07 INFO - Running setup.py (path:/tmp/pip-6QCryz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:07 INFO - Running setup.py (path:/tmp/pip-pPF0bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:07 INFO - Running setup.py (path:/tmp/pip-tb_cgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:07 INFO - Running setup.py (path:/tmp/pip-keumw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:08 INFO - Running setup.py (path:/tmp/pip-s0kdw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:08 INFO - Running setup.py (path:/tmp/pip-8ni6Vw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:08 INFO - Running setup.py (path:/tmp/pip-dyJ1BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:08 INFO - Running setup.py (path:/tmp/pip-N98dyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:08 INFO - Running setup.py (path:/tmp/pip-jPGwaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:08 INFO - Running setup.py (path:/tmp/pip-vg734d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:08 INFO - Running setup.py (path:/tmp/pip-Lnnmww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:08 INFO - Running setup.py (path:/tmp/pip-86JM57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:08 INFO - Running setup.py (path:/tmp/pip-l346y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:08 INFO - Running setup.py (path:/tmp/pip-Mj5yUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:08 INFO - Running setup.py (path:/tmp/pip-Sndt_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:08 INFO - Running setup.py install for manifestparser 11:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:08 INFO - Running setup.py install for mozcrash 11:40:09 INFO - Running setup.py install for mozdebug 11:40:09 INFO - Running setup.py install for mozdevice 11:40:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for mozfile 11:40:09 INFO - Running setup.py install for mozhttpd 11:40:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for mozinfo 11:40:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for mozInstall 11:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for mozleak 11:40:09 INFO - Running setup.py install for mozlog 11:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for moznetwork 11:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:09 INFO - Running setup.py install for mozprocess 11:40:10 INFO - Running setup.py install for mozprofile 11:40:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:10 INFO - Running setup.py install for mozrunner 11:40:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:10 INFO - Running setup.py install for mozscreenshot 11:40:10 INFO - Running setup.py install for moztest 11:40:10 INFO - Running setup.py install for mozversion 11:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:10 INFO - Cleaning up... 11:40:10 INFO - Return code: 0 11:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:10 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:40:10 INFO - Using env: {'DISPLAY': ':0', 11:40:10 INFO - 'HOME': '/home/cltbld', 11:40:10 INFO - 'LANG': 'en_US.UTF-8', 11:40:10 INFO - 'LANGUAGE': 'en_US:en', 11:40:10 INFO - 'LOGNAME': 'cltbld', 11:40:10 INFO - 'MAIL': '/var/mail/cltbld', 11:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:10 INFO - 'MOZ_NO_REMOTE': '1', 11:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:10 INFO - 'NO_EM_RESTART': '1', 11:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:10 INFO - 'PWD': '/builds/slave/test', 11:40:10 INFO - 'SHELL': '/bin/bash', 11:40:10 INFO - 'SHLVL': '1', 11:40:10 INFO - 'TERM': 'linux', 11:40:10 INFO - 'TMOUT': '86400', 11:40:10 INFO - 'USER': 'cltbld', 11:40:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:10 INFO - '_': '/tools/buildbot/bin/python'} 11:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:10 INFO - Running setup.py (path:/tmp/pip-MPJVQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:10 INFO - Running setup.py (path:/tmp/pip-8tORQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:10 INFO - Running setup.py (path:/tmp/pip-ZLBm0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:11 INFO - Running setup.py (path:/tmp/pip-5NdgjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:11 INFO - Running setup.py (path:/tmp/pip-WX_IlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:11 INFO - Running setup.py (path:/tmp/pip-xkfrXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:11 INFO - Running setup.py (path:/tmp/pip-ofEYCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:11 INFO - Running setup.py (path:/tmp/pip-XBlt5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:11 INFO - Running setup.py (path:/tmp/pip-0st2Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:11 INFO - Running setup.py (path:/tmp/pip-Q_7A8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:11 INFO - Running setup.py (path:/tmp/pip-IyKBE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:11 INFO - Running setup.py (path:/tmp/pip-8bui9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:11 INFO - Running setup.py (path:/tmp/pip-eCzv1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:11 INFO - Running setup.py (path:/tmp/pip-gRUsn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:11 INFO - Running setup.py (path:/tmp/pip-Pox3YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:11 INFO - Running setup.py (path:/tmp/pip-sPeoZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:12 INFO - Running setup.py (path:/tmp/pip-cm6UOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:40:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:13 INFO - Downloading blessings-1.6.tar.gz 11:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:14 INFO - Installing collected packages: blessings 11:40:14 INFO - Running setup.py install for blessings 11:40:14 INFO - Successfully installed blessings 11:40:14 INFO - Cleaning up... 11:40:14 INFO - Return code: 0 11:40:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:14 INFO - Reading from file tmpfile_stdout 11:40:14 INFO - Current package versions: 11:40:14 INFO - argparse == 1.2.1 11:40:14 INFO - blessings == 1.6 11:40:14 INFO - blobuploader == 1.2.4 11:40:14 INFO - docopt == 0.6.1 11:40:14 INFO - functools32 == 3.2.3-2 11:40:14 INFO - jsonschema == 2.5.1 11:40:14 INFO - manifestparser == 1.1 11:40:14 INFO - mozInstall == 1.12 11:40:14 INFO - mozcrash == 0.17 11:40:14 INFO - mozdebug == 0.1 11:40:14 INFO - mozdevice == 0.48 11:40:14 INFO - mozfile == 1.2 11:40:14 INFO - mozhttpd == 0.7 11:40:14 INFO - mozinfo == 0.9 11:40:14 INFO - mozleak == 0.1 11:40:14 INFO - mozlog == 3.2 11:40:14 INFO - moznetwork == 0.27 11:40:14 INFO - mozprocess == 0.22 11:40:14 INFO - mozprofile == 0.28 11:40:14 INFO - mozrunner == 6.11 11:40:14 INFO - mozscreenshot == 0.1 11:40:14 INFO - mozsystemmonitor == 0.3 11:40:14 INFO - moztest == 0.7 11:40:14 INFO - mozversion == 1.4 11:40:14 INFO - psutil == 3.1.1 11:40:14 INFO - requests == 1.2.3 11:40:14 INFO - wsgiref == 0.1.2 11:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:40:14 INFO - Using env: {'DISPLAY': ':0', 11:40:14 INFO - 'HOME': '/home/cltbld', 11:40:14 INFO - 'LANG': 'en_US.UTF-8', 11:40:14 INFO - 'LANGUAGE': 'en_US:en', 11:40:14 INFO - 'LOGNAME': 'cltbld', 11:40:14 INFO - 'MAIL': '/var/mail/cltbld', 11:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:14 INFO - 'MOZ_NO_REMOTE': '1', 11:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:14 INFO - 'NO_EM_RESTART': '1', 11:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:14 INFO - 'PWD': '/builds/slave/test', 11:40:14 INFO - 'SHELL': '/bin/bash', 11:40:14 INFO - 'SHLVL': '1', 11:40:14 INFO - 'TERM': 'linux', 11:40:14 INFO - 'TMOUT': '86400', 11:40:14 INFO - 'USER': 'cltbld', 11:40:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:14 INFO - '_': '/tools/buildbot/bin/python'} 11:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:40:14 INFO - Cleaning up... 11:40:14 INFO - Return code: 0 11:40:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:40:14 INFO - Using env: {'DISPLAY': ':0', 11:40:14 INFO - 'HOME': '/home/cltbld', 11:40:14 INFO - 'LANG': 'en_US.UTF-8', 11:40:14 INFO - 'LANGUAGE': 'en_US:en', 11:40:14 INFO - 'LOGNAME': 'cltbld', 11:40:14 INFO - 'MAIL': '/var/mail/cltbld', 11:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:14 INFO - 'MOZ_NO_REMOTE': '1', 11:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:14 INFO - 'NO_EM_RESTART': '1', 11:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:14 INFO - 'PWD': '/builds/slave/test', 11:40:14 INFO - 'SHELL': '/bin/bash', 11:40:14 INFO - 'SHLVL': '1', 11:40:14 INFO - 'TERM': 'linux', 11:40:14 INFO - 'TMOUT': '86400', 11:40:14 INFO - 'USER': 'cltbld', 11:40:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:14 INFO - '_': '/tools/buildbot/bin/python'} 11:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:14 INFO - Cleaning up... 11:40:14 INFO - Return code: 0 11:40:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 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 0x7fa8a6606f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2711350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:40:14 INFO - Using env: {'DISPLAY': ':0', 11:40:14 INFO - 'HOME': '/home/cltbld', 11:40:14 INFO - 'LANG': 'en_US.UTF-8', 11:40:14 INFO - 'LANGUAGE': 'en_US:en', 11:40:14 INFO - 'LOGNAME': 'cltbld', 11:40:14 INFO - 'MAIL': '/var/mail/cltbld', 11:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:14 INFO - 'MOZ_NO_REMOTE': '1', 11:40:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:14 INFO - 'NO_EM_RESTART': '1', 11:40:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:14 INFO - 'PWD': '/builds/slave/test', 11:40:14 INFO - 'SHELL': '/bin/bash', 11:40:14 INFO - 'SHLVL': '1', 11:40:14 INFO - 'TERM': 'linux', 11:40:14 INFO - 'TMOUT': '86400', 11:40:14 INFO - 'USER': 'cltbld', 11:40:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:14 INFO - '_': '/tools/buildbot/bin/python'} 11:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:15 INFO - Downloading/unpacking flake8 11:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:40:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:40:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:17 INFO - no previously-included directories found matching 'docs/_build' 11:40:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:40:17 INFO - Running setup.py install for pep8 11:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:17 INFO - no previously-included directories found matching 'docs/_build' 11:40:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:40:17 INFO - Cleaning up... 11:40:18 INFO - Return code: 0 11:40:18 INFO - Running post-action listener: _resource_record_post_action 11:40:18 INFO - Running post-action listener: _start_resource_monitoring 11:40:18 INFO - Starting resource monitoring. 11:40:18 INFO - ##### 11:40:18 INFO - ##### Finished create-virtualenv step (success) 11:40:18 INFO - ##### 11:40:18 INFO - ##### 11:40:18 INFO - ##### Running install step. 11:40:18 INFO - ##### 11:40:18 INFO - Running pre-action listener: _resource_record_pre_action 11:40:18 INFO - Running main action method: install 11:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:18 INFO - Reading from file tmpfile_stdout 11:40:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:18 INFO - Reading from file tmpfile_stdout 11:40:18 INFO - Output received: 11:40:18 INFO - Usage: mozinstall [options] installer 11:40:18 INFO - Options: 11:40:18 INFO - -h, --help show this help message and exit 11:40:18 INFO - -d DEST, --destination=DEST 11:40:18 INFO - Directory to install application into. [default: 11:40:18 INFO - "/builds/slave/test"] 11:40:18 INFO - --app=APP Application being installed. [default: firefox] 11:40:18 INFO - mkdir: /builds/slave/test/build/application 11:40:18 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'] 11:40:18 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 11:40:34 INFO - Reading from file tmpfile_stdout 11:40:34 INFO - Output received: 11:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:40:34 INFO - Running post-action listener: _resource_record_post_action 11:40:34 INFO - ##### 11:40:34 INFO - ##### Finished install step (success) 11:40:34 INFO - ##### 11:40:34 INFO - ##### 11:40:34 INFO - ##### Running run-tests step. 11:40:34 INFO - ##### 11:40:34 INFO - Running pre-action listener: _resource_record_pre_action 11:40:34 INFO - Running main action method: run_tests 11:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:34 INFO - Python 2.7.3 11:40:34 INFO - Return code: 0 11:40:34 INFO - grabbing minidump binary from tooltool 11:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:34 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 0x27a01c0>, '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 0x27a10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:40:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:40:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:34 INFO - Return code: 0 11:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:40:35 INFO - Return code: 0 11:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:40:35 INFO - Using env: {'DISPLAY': ':0', 11:40:35 INFO - 'HOME': '/home/cltbld', 11:40:35 INFO - 'LANG': 'en_US.UTF-8', 11:40:35 INFO - 'LANGUAGE': 'en_US:en', 11:40:35 INFO - 'LOGNAME': 'cltbld', 11:40:35 INFO - 'MAIL': '/var/mail/cltbld', 11:40:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:35 INFO - 'MOZ_NO_REMOTE': '1', 11:40:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:35 INFO - 'NO_EM_RESTART': '1', 11:40:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:35 INFO - 'PWD': '/builds/slave/test', 11:40:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:35 INFO - 'SHELL': '/bin/bash', 11:40:35 INFO - 'SHLVL': '1', 11:40:35 INFO - 'TERM': 'linux', 11:40:35 INFO - 'TMOUT': '86400', 11:40:35 INFO - 'USER': 'cltbld', 11:40:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138', 11:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:35 INFO - '_': '/tools/buildbot/bin/python'} 11:40:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:40:35 INFO - mozversion application_buildid: 20160608105728 11:40:35 INFO - mozversion application_changeset: 63ec66da50faad032454a44d3af3124c35102b3e 11:40:35 INFO - mozversion application_display_name: Nightly 11:40:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:35 INFO - mozversion application_name: Firefox 11:40:35 INFO - mozversion application_remotingname: firefox 11:40:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:40:35 INFO - mozversion application_vendor: Mozilla 11:40:35 INFO - mozversion application_version: 50.0a1 11:40:35 INFO - mozversion platform_buildid: 20160608105728 11:40:35 INFO - mozversion platform_changeset: 63ec66da50faad032454a44d3af3124c35102b3e 11:40:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:40:35 INFO - mozversion platform_version: 50.0a1 11:40:35 INFO - using testdate: 1465411235 11:40:35 INFO - actual date: 1465411235 11:40:35 INFO - starting webserver on 'localhost:45570' 11:40:35 INFO - SUITE-START | Running 2 tests 11:40:35 INFO - TEST-START | dromaeo_css 11:40:35 INFO - operating with platform_type : linux_ 11:40:35 INFO - Initialising browser for dromaeo_css test... 11:40:35 INFO - TEST-INFO | started process 4308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKBNjlS/profile http://localhost:45570/getInfo.html) 11:40:40 INFO - PROCESS | 4308 | __metrics Screen width/height:1600/1200 11:40:40 INFO - PROCESS | 4308 | colorDepth:24 11:40:40 INFO - PROCESS | 4308 | Browser inner width/height: 1024/697 11:40:40 INFO - PROCESS | 4308 | __metrics 11:40:40 ERROR - PROCESS | 4308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:40:41 INFO - TEST-INFO | 4308: exit 0 11:40:41 INFO - Browser initialized. 11:40:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:41 INFO - TEST-INFO | started process 4429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKBNjlS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:53 INFO - PROCESS | 4429 | RSS: Main: 168665088 11:40:53 INFO - PROCESS | 4429 | 11:41:43 INFO - PROCESS | 4429 | 1465411303315 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:43:55 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45570/tests/dromaeo/cssquery-ext.html) 11:43:57 INFO - PROCESS | 4429 | RSS: Main: 171155456 11:43:57 INFO - PROCESS | 4429 | 11:46:59 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-ext.html (next: http://localhost:45570/tests/dromaeo/cssquery-jquery.html) 11:46:59 INFO - PROCESS | 4429 | RSS: Main: 170221568 11:46:59 INFO - PROCESS | 4429 | 11:50:01 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45570/tests/dromaeo/cssquery-mootools.html) 11:50:02 INFO - PROCESS | 4429 | RSS: Main: 171757568 11:50:02 INFO - PROCESS | 4429 | 11:53:04 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45570/tests/dromaeo/cssquery-prototype.html) 11:53:04 INFO - PROCESS | 4429 | RSS: Main: 169123840 11:53:04 INFO - PROCESS | 4429 | 11:56:07 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45570/tests/dromaeo/cssquery-yui.html) 11:56:08 INFO - PROCESS | 4429 | RSS: Main: 170762240 11:56:08 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | Cycle 1(1): loaded http://localhost:45570/tests/dromaeo/cssquery-yui.html (next: http://localhost:45570/tests/dromaeo/cssquery-dojo.html) 11:59:10 INFO - PROCESS | 4429 | RSS: Main: 171737088 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | __start_tp_report 11:59:10 INFO - PROCESS | 4429 | _x_x_mozilla_page_load 11:59:10 INFO - PROCESS | 4429 | _x_x_mozilla_page_load_details 11:59:10 INFO - PROCESS | 4429 | |i|pagename|runs| 11:59:10 INFO - PROCESS | 4429 | |0;dojo.html;2674.986625066875;2694.7305269473045;2708.4853877763217;2729.8908043678252;2743.4101668141348;4764.976175119124;4765.428148622166;4798.808047678093;4866.586340161081;4868.878278043051;4736.881577960544;4811.711297322163;4849.709017458955;4888.584470320027;4904;4496.595306422413;4523.389342438762;4588.678792484528;4590.288505281686;4609.262517997121;413.01705059069235;4183.27678474276;4366.301391777316;4435.112977404516;4468.642508599304;4458.799354029076;4484.506704262529;4486.753228572427;4490.797914093873;4561.384213131218;4479;4493.820247190109;4500.054988452429;4526.298423744325;4573.451185857685;4381.802818873159;4432.955670443319;4457.375967364572;4489.775511224459;4498.280275155992;4748.762561871893;4770.0698363819065;4798.208295631217;4805.351277577517;4871.878203044952;5099.6685215460875;5277.86805329866;5281.419043905167;5299.49654782795;5352.304200453955;5234.16253399458;5279.445658205871;5281.815136470205;5287.629865909388;5298.735063246822;4900.632452566037;4904.386951631046;4916.655834091615;4920.3111564381015;4958.752062396866;5205.115130427836;5332.06688829461;5390.407055223922;5435.456454354612;5438.211459338374;5157.716325602128;5188.8962220755375;5202.791888324425;5213.973930130325;5260.894782104413;5301.54936830366;5303.840884773463;5308.283381743415;5310.468953104736;5355.86610334737;5022.799088036438;5124.718140502308;5180.1711726124395;5252.343457067866;5268.736563171903;5083.085044691991;5092.210707340369;5106.4382917879;5133.563647089964;5155.072087024371;4349.086691794695;4349.325854492558;4370.956290437055;4410.558944105564;4430.825831154747;3761.7554858934627;3773.415120656303;3808.0670235791854;3810.580836108026;3835.5972622874756;4332.631726303236;4378.058717375779;4378.16814805186;4395.956040439554;4481.910361792746;5202.791888324425;5205.7397130143345;5229.947700522946;5233.319668443154;5256.6320357574605;4342.2835232186335;4447.043885564619;4487.282034874404;4491.8203271869415;4507.233770259064;4718;4735.289706543977;4738.691985020962;4743.549362810528;4788.377510923558;4935.555799978019;4976.676516026447;4980.103581355391;4983.37707786534;5030.044291584587;5077.466865979019;5228.085085110167;5276.419593844597;5279.47205279469;5311.893762124659;4927.852164435073;4934.062528119646;4935.210366341368;4944.950550494449;4993.201087825931;5061.291419201389;5193.195054766517;5196.038732834438;5197.064528384927;5220.9477905220465;5177.119889618699;5207.609429292743;5237.397699264633;5240.082985477602;5279.128943724396;5071.695698258116;5077;5079.64442489037;5089.8727531812;5149.304843846033;4964.230544265644;5072.365954255718;5106.770195341144;5107.029664363759;5121.795128194831;5037.622178336566;5044.915343201083;5049.444561098349;5061.342025536656;5139.383274007143;5204.505571970657;5205.026915690601;5215.322008139069;5226.97386513065;5255.684658920477;4904.852854414374;5004.049230646166;5042;5095.566876815512;5109.08036553424 11:59:10 INFO - PROCESS | 4429 | |1;ext.html;546.1017114437562;583.3845293215658;593.1429084972215;601.7923816283384;616.5499185594518;35405.82297088514;38253.61746382535;38394;38804.611953880485;38943.610563894355;39014.804925975404;39710;39832.20335593286;39940.60059399405;40203.59796402035;7678.232176782319;7827.530348179099;7886.6845326186885;7893.999999999971;7901.249381308767;7756.340711039568;7833.569153696544;7836.2947334739865;7863.7640870773685;7901.841963160733;7806.882896756553;7875.251851074138;7879.645415956267;7882.566458844762;7930.444868859182;7795.532268063906;7850.2542258485355;7857.214278572125;7866.72466463671;7871.173526779691;7671;7699.230076992256;7750.883736743954;7768.495047821873;7784.104827944746;36324.27351452956;36409.45385819215;36513.26973460516;36676.26647467036;36820.44769328462;2982.9403411931858;3092.5361195820583;3127.9061628150966;3150.4486714824816;3187.2828613561765;28254.576181357297;28722.569161462387;28791;29318.267043323875;29334.559981600294;3278.278778668689;3397.5073614326034;3427.4516077427493;3437.604675462329;3439.105832483572;248866;249615;250058;250902;251746;54874.17688734672;55239.72380138154;55398.44601554013;55423.722881386144;55472.44527554673;29448.55827162594;29753.512324384126;29860.402791944038;30109.397812043637;30178.849105754332;15696.529104126894;15880.126593037494;15938.760918585998;15948.362065517249;15960;12011.939940300243;12201.816972745415;12210.57262995791;12214.57248996281;12256.877431225574;18064.36774712879;18134.637307253783;18137.909310453364;18153.45539633813;18178.000419953794;7034.683439245144;7234.819129521804;7246.4202863771825;7320.7071717131785;7418.851622967511;785.2814674572816;860.9956950215209;893.2095095840228;909.4952301472614;964.1370972979145;27714.3071423212;28462.288442789097;28664.186473304657;28740.712592873802;29009.41981160365;919.4621146629163;943.2783920300975;948.3788118782209;966.1691095374226;982.8967958364269;14055.156690598596;14214.218217997903;14322.78256348222;14421.134731915909;14521.201333926525;390978;391121;393627;393733;394043;48454.75772621185;49321;49519.75240123848;49712.751436243314;49837;1214.5688280660238;1229.6003798765437;1233.0320698251828;1252.2111070026008;1263.2799304396406;25683.101091462457;26865.328366790985;27068;27329.726702732718;27377.31556711098;41234.175316494104;42087.579124208365;42192;42255.366169508095;42364.36453453262;344805;345032;345717;345739;346859;24798.38004049913;24801.379965501008;25227.873860630578;25230.74769252284;25358;41347.793261033505;41358.58641413668;41519.58480415157;41750.79124604358;41976;35882.8205858969;36415.453768192965;36626.633733662326;36680.63319366772;37021.62978370182;35858;36278.63721362858;36300.09249768777;36467.27065458729;36533.26933461369;35540.466892997145;39334.60665393309;39476.605233948445;39816.20367592574;40254.1949161021;31919.6808031926;33548.496772547944;34007.149821254665;34088;34109.65890341164;25636.35909102213;25879.353016173995;26195.73804261933;26407.60388594211;26670.19989400321 11:59:10 INFO - PROCESS | 4429 | |2;jquery.html;368.50436163360285;368.85245901639325;376.570709391294;388.9941650875239;393.38435348679315;16281.592960176002;16734.58163545912;17190.22643981021;17198.656026879456;17982.417016046697;10583.10043646291;11104.944475277613;11129.944350278238;11144.665660030212;11180.161487888421;4670.2527595584625;4860.854174374775;4985.900281994358;5281.551068159211;5309.73451327434;5291.576673866081;5296;5297.629165958385;5355.839324820242;5662.886742265152;6038.124471951564;6042.305134909476;6072.453479186872;6091.116788065728;6097.603655762384;5395;5434;5731.283589551285;6006.9399306007035;6071.969640151793;5250.238715386286;5273.841784746463;5278.683279003272;5283.63014588979;5287.286216360781;12340.197887137398;16243.918780406022;20137.445424618738;20724;20777.272795452085;1707.77798886144;1798.1368942907347;1851.5093500222451;1958.3048017953563;2033.099052386024;8936.8659470108;9104.499252541107;9156.359054866161;9244.214241789456;12714.364281785965;1627.1457484820446;1662.9750553741703;1690.7886514185727;1697.1514242878561;1715.2795825753215;68673.31326686768;69188.30811691869;69378.65310673414;70573;72536;9913.851292230622;10058.647947321808;10163.695089147337;10544.578216871392;10843.891561084289;13810.447582096804;13942.721145577234;13973.091749036483;14024.158550487004;14036;7151.499395042401;7448.664810083559;7487.887681684779;7540.17058123606;7684.346830519356;7175.210726820045;7242.058532390755;7339.155997060299;7462.85074298511;7468.066491688539;4178.6657067434535;4327.32926396409;4407.42703448556;4431.357453169272;4473.463184417826;1794.3988763764023;1821.1713670279992;1853.1105069566413;1873.7283093951573;1885.3872491440336;793.3217099380063;872.5070335260684;891.7815135291895;930.4091901642371;935.9812803743887;16069;16407.589810254838;16520.83479165217;16835.579110522336;17018.914905425394;826.6197549127348;851.2338894994431;859.0936561927102;879.7096958003843;884.9292056635454;9099.909000910038;9507.714768556954;9521.809563808685;9569.282303827102;9589.42463452195;390661;395241.56420815527;398057;400446.99106017716;402239;56148.71925640427;75846.62076689691;77689.611551943;78736.60631696804;78984;879.7360791762574;892.4912799704236;897.4794619120894;913.255696607263;921.1801496667837;15254.389824407343;15321.923390382977;15441.22793860325;15464.922675386551;15982.680346392774;36130.63869361378;36743.26513469769;36788.63211367852;36819.447708283864;37056.44415333826;49073.5092649069;49781;50770.74614626903;51276;52133;7579.393648507996;7591.278828511283;7599.354054905174;7646.464747467847;7671.117821450604;10717.517711702836;11729.178957473236;11850.992665623518;11904.464299106734;12331.876681233072;9244.583993720433;9790.706278811647;9875.456849873039;9917.256205784452;10234.334768240338;10653.9467302663;10664.360138391721;10759.30064545802;10859.782804344028;10861.728456788644;10019.949900250453;10036.548355324174;10148.391096534231;10572.471376430994;10670.83993740079;7692.307692307719;7879.803004924923;7915.762527124196;8115.79710507242;8115.959420203098;9280.72157835266;9519;9920;9978.101970822661;10530.999555042565 11:59:10 INFO - PROCESS | 4429 | |3;mootools.html;1422.6301161697957;1452.0416525093437;1509.4113295814627;1677.7231756760127;1678.5719641491419;6722.630255335955;7465.738699145531;7571.73498927537;8101.91898081019;8109.189081091888;7653.923460765404;7855.8821617675785;7938.40461965352;7939.404544659144;7955.164707705694;2200.801927826495;2224.6218142915745;2231.944201394962;2236.552689462114;2241.8430709850318;2177.3250292409325;2194.3746032380773;2210.734711834582;2226.554689062186;2226.5880812049822;2140.122549754601;2148.258850696507;2157.4714195022243;2158.3201291593177;2177.6515757478805;2173.1850556041486;2183.15948359881;2183.552371763785;2183.705199798023;2187.649976003832;2159.6976423300753;2160.0711693971584;2187.89060546972;2188.7811218878146;2192.9890350548303;7793.688252469894;7882.448228623941;7884.881726774103;7888.013998250219;7897.368210543143;4495.797689103998;4599.218132917378;4605;4681.157391669498;4754.952450475485;2880.6111174991315;2907.4766542022426;2985.9850700746356;2990.8355040472766;3009.9548506772417;949.5489642419865;960.8894977077656;965.6764983730459;987.4963768478057;1004.7889943111956;10637.46812659364;10644.095251903598;10670.73323166927;10689.679309620646;10718.732031699192;4214.30463973441;4307.870763877088;4335.1979883721615;4388.363687265329;4395.582419670126;9068.410553314014;9114.36199466031;9119.316051296179;9123;9146.085391460934;4705.670603057753;4765.26138448541;4809.422869255642;4822.9758851206225;4832.178529649968;3592.586852511942;4188.162367526507;4322.956770432318;4385.429894113745;4430;3604.585472670624;3607.9278414432088;3682.0610744260043;3683.4290684943876;3814.5803961564206;1140.2075557487633;1144.3248483394837;1157.2304417562395;1159.8492196014633;1161.3902701082;817.345218977927;829.3738227638215;831.7130589946458;831.9875201871977;833.0045595513425;4962.751862406937;4969.676970996946;4978.228374601942;5068;5083.212102124176;407.95512493625677;410.517641770918;411.475368904649;420.48910573652546;424.3232044888398;3876.5348158221195;3985.80070996449;4004;4024.2555127300957;4067.8169482373364;9766.75583110428;9898.208143348515;9963.551640176209;9973.351732137387;10002.899971000197;9840.803183936425;9855.45794981283;10021.79956400868;10041.297109202433;10049.748756281151;7445.255474452511;7636.923630763732;7644.961775191088;7649.847003059907;7682.501912127082;5391.353037635509;5455.8363249102595;5577.581681373995;5585.832425027255;5664.85837854057;8888.555572221492;9035.232005279362;9144.131307525775;9150.993390726882;9194.586243619187;8916.55417229149;9180.678676246567;9422.057794220524;9429.481378524248;9461.905380946102;6555.180602424697;6583.604983700993;6699;6709.630970296681;6743.055972163803;7522;7590.96204518996;7602.201768814416;7611.2769286917655;7671.079470463357;6667.966660166668;6784.084148640068;6834.077399550997;6858.965705171442;6885.311468853275;6674.866502670016;6737.3599508046655;6786.660666966731;6824.385805277549;6888.242293347828;6337.936620633919;6364.331745166691;6391.6804159792755;6395.360463953567;6406.359364063556;4457.665675074318;4473.821047158207;4557.977210113928;4591.357209990537;4631.768411579475;4527.547245275446;4548.226801443696;4578.153041687298;4595.609373203315;4655.4180727409075 11:59:10 INFO - PROCESS | 4429 | |4;prototype.html;289.88839296870714;297.9791414600978;302.6413699765778;303.45681230597233;308.4278663079988;4876.43920949091;4898.559129678329;4928.728919909404;5020.698758074518;5035.924461133086;4950.3317052197945;4976.527229913152;4983.127952608297;5007.4491805901325;5020.824271150511;3932.213557288547;3935.7048221383366;3943.881683549498;3946.3291240489184;3967.3453880109746;3690.24350008249;3950.308695978192;3969.6701604962373;3982.1637456134245;4005.6194661507257;3808.8286027128706;3828.157805282847;3834.78908660025;3843.2889915365745;3859.459675645412;3834.2331533693373;3848.749831260973;3859.9228015439535;3875.1087249932393;3879.941800872989;3327.467605183159;3346.113279980807;3378.932421351584;3391.5082313064468;3401.6598340166033;4655.557722016403;4723.433188017426;4765.189917713997;4771.23660214364;4772.928406073912;4331.436913201295;4368.366586844922;4402.547159437378;4413.624841888443;4415.337699345092;5121.564667003272;5149.845504634867;5157.123289040835;5176.870578235536;5210.583153347761;3602.2975519773654;3685.3366394049062;3697.5932647408763;3699.204670995749;3703.370427027412;5423.186522021729;5441.265429167091;5446.91829622556;5487.807926722546;5513.283273174462;3729.850805967785;3742.6631603155847;3744.8689295874515;3753.436984452354;3777.017066040296;3781.5840257571645;3784.905377365533;3786.2995345861104;3790.166163444038;3820.426935959573;4293.8711838644895;4351.19502891966;4358.777023717927;4370.956290437055;4373.584509471595;5220.869478263074;5223.869403264873;5244.187150991603;5247.7667748079175;5266.183741520071;1232.9136960412864;1272.8727127287382;1310.1484035377082;1310.4758096761373;1313.2973858985397;809.2635701511596;829.8340331933516;838.3209600223838;841.8232171243985;842.4902933725131;4033.1933613276874;4036.717429779946;4044.211378781168;4065.3495440729935;4075.2053349596545;4758.238681810963;4759.76201189946;4776.95223047772;4814.614830813526;4835.8065677372515;4006.117124951268;4042.3532234842282;4070.9796451017555;4083.8967931515294;4089.488813898263;2501.287133167075;2674.2244749022566;2877.2662970942692;2882.875678485392;2895.4798730666566;5070.783012077075;5077.695338279641;5080.974595127001;5103.464136265713;5117.565006974449;5261.4738526147075;5526.778928842801;5538.944610553924;5559.471850174227;5559.722013899289;5040.218766091261;5040.36995375578;5042.42012168598;5116.411612664591;5117.616178786606;5372.409035006068;5382.542483888913;5419.945800541944;5426.213199086032;5444.128939369682;5116.334876466036;5241.659292145999;5251.212318152155;5272.762725677277;5291.814786482455;5101.495058957542;5107.974460127824;5128.30765847277;5142.97428512855;5150.356205474316;3717.368047431997;3729.9929019165215;3739.9065023373546;3746.3443897317316;3746.4380342948775;5168.612354073384;5326.9200961984825;5333.7866485340155;5338.919916201183;5425.131978883517;5161.535461808456;5168.767405466839;5175.585953123666;5190.532852043183;5193.143131383431;5137.6660517066275;5161.458046905021;5173.508516690908;5184.351956005499;5196.220022288057;5018.197088465828;5099.801546636463;5107.599428268708;5122.257272695364;5151.845444636667;5216.7130807804415;5226.63413561047;5234.947650523446;5238.895222095613;5242.842714718565;5115.872103197301;5118.846434606968;5151.922721159111;5154.273318438215;5159.17453207485 11:59:10 INFO - PROCESS | 4429 | |5;yui.html;644.829120283125;656.924453687826;666.1739443090569;740.8259059121106;768.6809973860846;11989.160758746892;12799.680007999805;12847.164934279266;12861.164024338423;12886.935565322172;11393.715157121076;11414.771704565903;11438.885611143885;11484.827727584094;13693.931530342334;802.9959850200755;804.8309854930471;806.5523634382915;806.9757907262791;807.0436532708729;629.527854109418;787.0791174326052;809.9635516401776;815.384384789486;816.3673153306205;854.0775961961067;857.2413414128509;858.1975852577829;858.8325276571071;859.6131740716671;825.3438516379492;830.8587540118194;832.675256649907;832.6794184239081;834.4867906237681;606.7178761875705;606.7754930675678;607.0317843040343;609.0194786393902;610.4749915073033;13298.069135160446;13408.731825363535;13452.461901523928;13468.326583670876;13469.461221551126;13566.59300220995;13744.244066576335;13752.587422377344;13875.861241387558;13905.096168749;10139.797204055878;10226.846597301046;10290.279680422373;10411.583536658525;10506.947465262625;3405.744569157323;3421.349943510725;3422.3668621305137;3422.3668621305137;3423.880164194266;57508.71245643787;57518.13722794162;58451.70774146102;58705.41294587042;59138.40861591372;10766.892331076746;10815.729606759895;10890.29213101146;10913.126949843994;11081.72295692598;19983.300584479475;20051.398458046282;20076.89961550183;20106.69839952402;20132.89933550352;6796.349184158506;7001.649917504104;7110.502264841515;7218.927810721931;7276.890846637305;3674.6325367463573;3687.649673281034;3717.8326975285636;3776.4335349697767;3854.71089668276;2739.7123302052996;2858.742713155826;2862.4561333347015;2867.068202834087;2874.0228322370494;515.1294312611674;516.4886762105489;521.0048806779034;521.2259794205602;522.1306524636514;478.92097803861975;492.2861850316983;498.95468992460735;507.1783710389193;507.28219569309016;6824.146981627297;6857.451403887677;6908.861822763517;6952.965235173791;7070.646467676595;382.32328778062674;417.31768558407225;456.08099679146545;469.58207195595946;470.28751441566055;3410.1645096951406;3481.617022127564;3484.094135524731;3555.7333200010103;3569.714422846166;54716;54955.45044549583;55290;55350.72324638351;70687;51918;77148.61425692835;78042.60978695184;79350.6032469834;81305;67880.3211967874;68631.65684171548;68729.63518240879;69594;70860.64569677222;6545.901811472927;6612.768553100618;6631.701573429304;6668.233153187445;6693.598384096969;42464.39548287084;44031;44105.11789764251;44751.32873006973;44924.55075449334;58214.708926455096;60437;60878.39121608727;61518;61560.69219653873;9190.862137068083;9203.677871274473;9270.629174832931;9348.345615806827;9478.241740660593;9182.586783594888;9319.673811416567;9517.714468565953;9540.093691099335;9659.034096590285;8530.445521041112;8538.530380829114;8542.572871356531;8573.485590864568;8621.137886211329;8687;8802.163794439519;8941.37410381293;8978.551072446482;9030.413023153475;8310.916890831015;8374.581270936307;8437.578121094044;8504.787380315542;8589.098144694717;7494.925050749423;7674.270944260286;7737.806554836174;7779.37764978789;7924.326432253092;7474.327310542078;7525.285097915689;7707.306342429209;7786.7663970080985;7818.413618978713 11:59:10 INFO - PROCESS | 4429 | __end_tp_report 11:59:10 INFO - PROCESS | 4429 | __start_cc_report 11:59:10 INFO - PROCESS | 4429 | _x_x_mozilla_cycle_collect,385 11:59:10 INFO - PROCESS | 4429 | __end_cc_report 11:59:10 INFO - PROCESS | 4429 | __startTimestamp1465412350830__endTimestamp 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | ------- Summary: start ------- 11:59:10 INFO - PROCESS | 4429 | Number of tests: 6 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#0] dojo.html Cycles:165 Average:4800.99 Median:4976.68 stddev:627.52 (12.6%) stddev-sans-first:606.88 11:59:10 INFO - PROCESS | 4429 | Values: 2675.0 2694.7 2708.5 2729.9 2743.4 4765.0 4765.4 4798.8 4866.6 4868.9 4736.9 4811.7 4849.7 4888.6 4904.0 4496.6 4523.4 4588.7 4590.3 4609.3 413.0 4183.3 4366.3 4435.1 4468.6 4458.8 4484.5 4486.8 4490.8 4561.4 4479.0 4493.8 4500.1 4526.3 4573.5 4381.8 4433.0 4457.4 4489.8 4498.3 4748.8 4770.1 4798.2 4805.4 4871.9 5099.7 5277.9 5281.4 5299.5 5352.3 5234.2 5279.4 5281.8 5287.6 5298.7 4900.6 4904.4 4916.7 4920.3 4958.8 5205.1 5332.1 5390.4 5435.5 5438.2 5157.7 5188.9 5202.8 5214.0 5260.9 5301.5 5303.8 5308.3 5310.5 5355.9 5022.8 5124.7 5180.2 5252.3 5268.7 5083.1 5092.2 5106.4 5133.6 5155.1 4349.1 4349.3 4371.0 4410.6 4430.8 3761.8 3773.4 3808.1 3810.6 3835.6 4332.6 4378.1 4378.2 4396.0 4481.9 5202.8 5205.7 5229.9 5233.3 5256.6 4342.3 4447.0 4487.3 4491.8 4507.2 4718.0 4735.3 4738.7 4743.5 4788.4 4935.6 4976.7 4980.1 4983.4 5030.0 5077.5 5228.1 5276.4 5279.5 5311.9 4927.9 4934.1 4935.2 4945.0 4993.2 5061.3 5193.2 5196.0 5197.1 5220.9 5177.1 5207.6 5237.4 5240.1 5279.1 5071.7 5077.0 5079.6 5089.9 5149.3 4964.2 5072.4 5106.8 5107.0 5121.8 5037.6 5044.9 5049.4 5061.3 5139.4 5204.5 5205.0 5215.3 5227.0 5255.7 4904.9 5004.0 5042.0 5095.6 5109.1 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#1] ext.html Cycles:180 Average:47743.08 Median:36523.27 stddev:88243.34 (241.6%) stddev-sans-first:88419.74 11:59:10 INFO - PROCESS | 4429 | Values: 546.1 583.4 593.1 601.8 616.5 35405.8 38253.6 38394.0 38804.6 38943.6 39014.8 39710.0 39832.2 39940.6 40203.6 7678.2 7827.5 7886.7 7894.0 7901.2 7756.3 7833.6 7836.3 7863.8 7901.8 7806.9 7875.3 7879.6 7882.6 7930.4 7795.5 7850.3 7857.2 7866.7 7871.2 7671.0 7699.2 7750.9 7768.5 7784.1 36324.3 36409.5 36513.3 36676.3 36820.4 2982.9 3092.5 3127.9 3150.4 3187.3 28254.6 28722.6 28791.0 29318.3 29334.6 3278.3 3397.5 3427.5 3437.6 3439.1 248866.0 249615.0 250058.0 250902.0 251746.0 54874.2 55239.7 55398.4 55423.7 55472.4 29448.6 29753.5 29860.4 30109.4 30178.8 15696.5 15880.1 15938.8 15948.4 15960.0 12011.9 12201.8 12210.6 12214.6 12256.9 18064.4 18134.6 18137.9 18153.5 18178.0 7034.7 7234.8 7246.4 7320.7 7418.9 785.3 861.0 893.2 909.5 964.1 27714.3 28462.3 28664.2 28740.7 29009.4 919.5 943.3 948.4 966.2 982.9 14055.2 14214.2 14322.8 14421.1 14521.2 390978.0 391121.0 393627.0 393733.0 394043.0 48454.8 49321.0 49519.8 49712.8 49837.0 1214.6 1229.6 1233.0 1252.2 1263.3 25683.1 26865.3 27068.0 27329.7 27377.3 41234.2 42087.6 42192.0 42255.4 42364.4 344805.0 345032.0 345717.0 345739.0 346859.0 24798.4 24801.4 25227.9 25230.7 25358.0 41347.8 41358.6 41519.6 41750.8 41976.0 35882.8 36415.5 36626.6 36680.6 37021.6 35858.0 36278.6 36300.1 36467.3 36533.3 35540.5 39334.6 39476.6 39816.2 40254.2 31919.7 33548.5 34007.1 34088.0 34109.7 25636.4 25879.4 26195.7 26407.6 26670.2 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#2] jquery.html Cycles:180 Average:24249.77 Median:27383.45 stddev:65530.74 (239.3%) stddev-sans-first:65690.04 11:59:10 INFO - PROCESS | 4429 | Values: 368.5 368.9 376.6 389.0 393.4 16281.6 16734.6 17190.2 17198.7 17982.4 10583.1 11104.9 11129.9 11144.7 11180.2 4670.3 4860.9 4985.9 5281.6 5309.7 5291.6 5296.0 5297.6 5355.8 5662.9 6038.1 6042.3 6072.5 6091.1 6097.6 5395.0 5434.0 5731.3 6006.9 6072.0 5250.2 5273.8 5278.7 5283.6 5287.3 12340.2 16243.9 20137.4 20724.0 20777.3 1707.8 1798.1 1851.5 1958.3 2033.1 8936.9 9104.5 9156.4 9244.2 12714.4 1627.1 1663.0 1690.8 1697.2 1715.3 68673.3 69188.3 69378.7 70573.0 72536.0 9913.9 10058.6 10163.7 10544.6 10843.9 13810.4 13942.7 13973.1 14024.2 14036.0 7151.5 7448.7 7487.9 7540.2 7684.3 7175.2 7242.1 7339.2 7462.9 7468.1 4178.7 4327.3 4407.4 4431.4 4473.5 1794.4 1821.2 1853.1 1873.7 1885.4 793.3 872.5 891.8 930.4 936.0 16069.0 16407.6 16520.8 16835.6 17018.9 826.6 851.2 859.1 879.7 884.9 9099.9 9507.7 9521.8 9569.3 9589.4 390661.0 395241.6 398057.0 400447.0 402239.0 56148.7 75846.6 77689.6 78736.6 78984.0 879.7 892.5 897.5 913.3 921.2 15254.4 15321.9 15441.2 15464.9 15982.7 36130.6 36743.3 36788.6 36819.4 37056.4 49073.5 49781.0 50770.7 51276.0 52133.0 7579.4 7591.3 7599.4 7646.5 7671.1 10717.5 11729.2 11851.0 11904.5 12331.9 9244.6 9790.7 9875.5 9917.3 10234.3 10653.9 10664.4 10759.3 10859.8 10861.7 10019.9 10036.5 10148.4 10572.5 10670.8 7692.3 7879.8 7915.8 8115.8 8116.0 9280.7 9519.0 9920.0 9978.1 10531.0 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#3] mootools.html Cycles:180 Average:5202.62 Median:4760.11 stddev:2940.75 (61.8%) stddev-sans-first:2935.29 11:59:10 INFO - PROCESS | 4429 | Values: 1422.6 1452.0 1509.4 1677.7 1678.6 6722.6 7465.7 7571.7 8101.9 8109.2 7653.9 7855.9 7938.4 7939.4 7955.2 2200.8 2224.6 2231.9 2236.6 2241.8 2177.3 2194.4 2210.7 2226.6 2226.6 2140.1 2148.3 2157.5 2158.3 2177.7 2173.2 2183.2 2183.6 2183.7 2187.6 2159.7 2160.1 2187.9 2188.8 2193.0 7793.7 7882.4 7884.9 7888.0 7897.4 4495.8 4599.2 4605.0 4681.2 4755.0 2880.6 2907.5 2986.0 2990.8 3010.0 949.5 960.9 965.7 987.5 1004.8 10637.5 10644.1 10670.7 10689.7 10718.7 4214.3 4307.9 4335.2 4388.4 4395.6 9068.4 9114.4 9119.3 9123.0 9146.1 4705.7 4765.3 4809.4 4823.0 4832.2 3592.6 4188.2 4323.0 4385.4 4430.0 3604.6 3607.9 3682.1 3683.4 3814.6 1140.2 1144.3 1157.2 1159.8 1161.4 817.3 829.4 831.7 832.0 833.0 4962.8 4969.7 4978.2 5068.0 5083.2 408.0 410.5 411.5 420.5 424.3 3876.5 3985.8 4004.0 4024.3 4067.8 9766.8 9898.2 9963.6 9973.4 10002.9 9840.8 9855.5 10021.8 10041.3 10049.7 7445.3 7636.9 7645.0 7649.8 7682.5 5391.4 5455.8 5577.6 5585.8 5664.9 8888.6 9035.2 9144.1 9151.0 9194.6 8916.6 9180.7 9422.1 9429.5 9461.9 6555.2 6583.6 6699.0 6709.6 6743.1 7522.0 7591.0 7602.2 7611.3 7671.1 6668.0 6784.1 6834.1 6859.0 6885.3 6674.9 6737.4 6786.7 6824.4 6888.2 6337.9 6364.3 6391.7 6395.4 6406.4 4457.7 4473.8 4558.0 4591.4 4631.8 4527.5 4548.2 4578.2 4595.6 4655.4 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#4] prototype.html Cycles:180 Average:4272.48 Median:4887.50 stddev:1261.35 (25.8%) stddev-sans-first:1228.96 11:59:10 INFO - PROCESS | 4429 | Values: 289.9 298.0 302.6 303.5 308.4 4876.4 4898.6 4928.7 5020.7 5035.9 4950.3 4976.5 4983.1 5007.4 5020.8 3932.2 3935.7 3943.9 3946.3 3967.3 3690.2 3950.3 3969.7 3982.2 4005.6 3808.8 3828.2 3834.8 3843.3 3859.5 3834.2 3848.7 3859.9 3875.1 3879.9 3327.5 3346.1 3378.9 3391.5 3401.7 4655.6 4723.4 4765.2 4771.2 4772.9 4331.4 4368.4 4402.5 4413.6 4415.3 5121.6 5149.8 5157.1 5176.9 5210.6 3602.3 3685.3 3697.6 3699.2 3703.4 5423.2 5441.3 5446.9 5487.8 5513.3 3729.9 3742.7 3744.9 3753.4 3777.0 3781.6 3784.9 3786.3 3790.2 3820.4 4293.9 4351.2 4358.8 4371.0 4373.6 5220.9 5223.9 5244.2 5247.8 5266.2 1232.9 1272.9 1310.1 1310.5 1313.3 809.3 829.8 838.3 841.8 842.5 4033.2 4036.7 4044.2 4065.3 4075.2 4758.2 4759.8 4777.0 4814.6 4835.8 4006.1 4042.4 4071.0 4083.9 4089.5 2501.3 2674.2 2877.3 2882.9 2895.5 5070.8 5077.7 5081.0 5103.5 5117.6 5261.5 5526.8 5538.9 5559.5 5559.7 5040.2 5040.4 5042.4 5116.4 5117.6 5372.4 5382.5 5419.9 5426.2 5444.1 5116.3 5241.7 5251.2 5272.8 5291.8 5101.5 5108.0 5128.3 5143.0 5150.4 3717.4 3730.0 3739.9 3746.3 3746.4 5168.6 5326.9 5333.8 5338.9 5425.1 5161.5 5168.8 5175.6 5190.5 5193.1 5137.7 5161.5 5173.5 5184.4 5196.2 5018.2 5099.8 5107.6 5122.3 5151.8 5216.7 5226.6 5234.9 5238.9 5242.8 5115.9 5118.8 5151.9 5154.3 5159.2 11:59:10 INFO - PROCESS | 4429 | 11:59:10 INFO - PROCESS | 4429 | [#5] yui.html Cycles:180 Average:15470.64 Median:30743.71 stddev:21227.66 (69.0%) stddev-sans-first:21258.02 11:59:10 INFO - PROCESS | 4429 | Values: 644.8 656.9 666.2 740.8 768.7 11989.2 12799.7 12847.2 12861.2 12886.9 11393.7 11414.8 11438.9 11484.8 13693.9 803.0 804.8 806.6 807.0 807.0 629.5 787.1 810.0 815.4 816.4 854.1 857.2 858.2 858.8 859.6 825.3 830.9 832.7 832.7 834.5 606.7 606.8 607.0 609.0 610.5 13298.1 13408.7 13452.5 13468.3 13469.5 13566.6 13744.2 13752.6 13875.9 13905.1 10139.8 10226.8 10290.3 10411.6 10506.9 3405.7 3421.3 3422.4 3422.4 3423.9 57508.7 57518.1 58451.7 58705.4 59138.4 10766.9 10815.7 10890.3 10913.1 11081.7 19983.3 20051.4 20076.9 20106.7 20132.9 6796.3 7001.6 7110.5 7218.9 7276.9 3674.6 3687.6 3717.8 3776.4 3854.7 2739.7 2858.7 2862.5 2867.1 2874.0 515.1 516.5 521.0 521.2 522.1 478.9 492.3 499.0 507.2 507.3 6824.1 6857.5 6908.9 6953.0 7070.6 382.3 417.3 456.1 469.6 470.3 3410.2 3481.6 3484.1 3555.7 3569.7 54716.0 54955.5 55290.0 55350.7 70687.0 51918.0 77148.6 78042.6 79350.6 81305.0 67880.3 68631.7 68729.6 69594.0 70860.6 6545.9 6612.8 6631.7 6668.2 6693.6 42464.4 44031.0 44105.1 44751.3 44924.6 58214.7 60437.0 60878.4 61518.0 61560.7 9190.9 9203.7 9270.6 9348.3 9478.2 9182.6 9319.7 9517.7 9540.1 9659.0 8530.4 8538.5 8542.6 8573.5 8621.1 8687.0 8802.2 8941.4 8978.6 9030.4 8310.9 8374.6 8437.6 8504.8 8589.1 7494.9 7674.3 7737.8 7779.4 7924.3 7474.3 7525.3 7707.3 7786.8 7818.4 11:59:10 INFO - PROCESS | 4429 | -------- Summary: end -------- 11:59:10 INFO - PROCESS | 4429 | 11:59:11 INFO - TEST-INFO | 4429: exit 0 11:59:11 INFO - TEST-OK | dromaeo_css | took 1116165ms 11:59:11 INFO - TEST-START | kraken 11:59:11 INFO - operating with platform_type : linux_ 11:59:11 INFO - Initialising browser for kraken test... 11:59:11 INFO - TEST-INFO | started process 4664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa7iG0l/profile http://localhost:45570/getInfo.html) 11:59:16 INFO - PROCESS | 4664 | __metrics Screen width/height:1600/1200 11:59:16 INFO - PROCESS | 4664 | colorDepth:24 11:59:16 INFO - PROCESS | 4664 | Browser inner width/height: 1024/697 11:59:16 INFO - PROCESS | 4664 | __metrics 11:59:17 ERROR - PROCESS | 4664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:59:17 INFO - TEST-INFO | 4664: exit 0 11:59:17 INFO - Browser initialized. 11:59:17 INFO - Running cycle 1/1 for kraken test... 11:59:17 INFO - TEST-INFO | started process 4783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa7iG0l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:29 INFO - PROCESS | 4783 | RSS: Main: 168267776 11:59:29 INFO - PROCESS | 4783 | 11:59:32 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45570/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:33 INFO - PROCESS | 4783 | RSS: Main: 173412352 11:59:33 INFO - PROCESS | 4783 | 11:59:36 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45570/tests/kraken/driver.html?testName=audio-dft) 11:59:36 INFO - PROCESS | 4783 | RSS: Main: 173334528 11:59:36 INFO - PROCESS | 4783 | 11:59:39 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45570/tests/kraken/driver.html?testName=audio-fft) 11:59:40 INFO - PROCESS | 4783 | RSS: Main: 168304640 11:59:40 INFO - PROCESS | 4783 | 11:59:42 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45570/tests/kraken/driver.html?testName=audio-oscillator) 11:59:43 INFO - PROCESS | 4783 | RSS: Main: 168611840 11:59:43 INFO - PROCESS | 4783 | 11:59:45 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:46 INFO - PROCESS | 4783 | RSS: Main: 169172992 11:59:46 INFO - PROCESS | 4783 | 11:59:49 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45570/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:50 INFO - PROCESS | 4783 | RSS: Main: 169353216 11:59:50 INFO - PROCESS | 4783 | 11:59:53 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45570/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:54 INFO - PROCESS | 4783 | RSS: Main: 166526976 11:59:54 INFO - PROCESS | 4783 | 11:59:57 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45570/tests/kraken/driver.html?testName=json-parse-financial) 11:59:57 INFO - PROCESS | 4783 | RSS: Main: 167849984 11:59:57 INFO - PROCESS | 4783 | 11:59:59 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:00 INFO - PROCESS | 4783 | RSS: Main: 168189952 12:00:00 INFO - PROCESS | 4783 | 12:00:02 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:02 INFO - PROCESS | 4783 | RSS: Main: 168468480 12:00:02 INFO - PROCESS | 4783 | 12:00:04 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:05 INFO - PROCESS | 4783 | RSS: Main: 168591360 12:00:05 INFO - PROCESS | 4783 | 12:00:08 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:09 INFO - PROCESS | 4783 | RSS: Main: 168505344 12:00:09 INFO - PROCESS | 4783 | 12:00:12 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:12 INFO - PROCESS | 4783 | RSS: Main: 168366080 12:00:12 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | Cycle 1(1): loaded http://localhost:45570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45570/tests/kraken/driver.html?testName=ai-astar) 12:00:14 INFO - PROCESS | 4783 | RSS: Main: 169127936 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | __start_tp_report 12:00:14 INFO - PROCESS | 4783 | _x_x_mozilla_page_load 12:00:14 INFO - PROCESS | 4783 | _x_x_mozilla_page_load_details 12:00:14 INFO - PROCESS | 4783 | |i|pagename|runs| 12:00:14 INFO - PROCESS | 4783 | |0;ai-astar;116;109;113;114;115;112;113;113;114;115 12:00:14 INFO - PROCESS | 4783 | |1;audio-beat-detection;164;138;159;184;135;161;162;139;214;135 12:00:14 INFO - PROCESS | 4783 | |2;audio-dft;163;162;165;174;163;162;163;164;160;164 12:00:14 INFO - PROCESS | 4783 | |3;audio-fft;75;81;75;165;76;77;76;75;164;76 12:00:14 INFO - PROCESS | 4783 | |4;audio-oscillator;87;87;141;86;87;88;144;86;87;134 12:00:14 INFO - PROCESS | 4783 | |5;imaging-gaussian-blur;118;118;118;117;118;120;118;117;118;117 12:00:14 INFO - PROCESS | 4783 | |6;imaging-darkroom;148;148;147;147;147;148;148;147;147;147 12:00:14 INFO - PROCESS | 4783 | |7;imaging-desaturate;95;96;96;95;96;95;96;95;96;96 12:00:14 INFO - PROCESS | 4783 | |8;json-parse-financial;68;62;62;63;64;63;63;63;63;63 12:00:14 INFO - PROCESS | 4783 | |9;json-stringify-tinderbox;65;66;67;66;65;66;66;65;66;65 12:00:14 INFO - PROCESS | 4783 | |10;stanford-crypto-aes;84;84;83;87;85;89;91;84;107;85 12:00:14 INFO - PROCESS | 4783 | |11;stanford-crypto-ccm;143;133;133;139;144;136;139;159;151;136 12:00:14 INFO - PROCESS | 4783 | |12;stanford-crypto-pbkdf2;172;172;179;171;174;174;168;173;172;168 12:00:14 INFO - PROCESS | 4783 | |13;stanford-crypto-sha256-iterative;68;67;77;71;70;67;68;70;69;67 12:00:14 INFO - PROCESS | 4783 | __end_tp_report 12:00:14 INFO - PROCESS | 4783 | __start_cc_report 12:00:14 INFO - PROCESS | 4783 | _x_x_mozilla_cycle_collect,992 12:00:14 INFO - PROCESS | 4783 | __end_cc_report 12:00:14 INFO - PROCESS | 4783 | __startTimestamp1465412414738__endTimestamp 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | ------- Summary: start ------- 12:00:14 INFO - PROCESS | 4783 | Number of tests: 14 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:1.83 12:00:14 INFO - PROCESS | 4783 | Values: 116.0 109.0 113.0 114.0 115.0 112.0 113.0 113.0 114.0 115.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#1] audio-beat-detection Cycles:10 Average:159.10 Median:161.50 stddev:25.12 (15.6%) stddev-sans-first:26.59 12:00:14 INFO - PROCESS | 4783 | Values: 164.0 138.0 159.0 184.0 135.0 161.0 162.0 139.0 214.0 135.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.77 (2.3%) stddev-sans-first:3.98 12:00:14 INFO - PROCESS | 4783 | Values: 163.0 162.0 165.0 174.0 163.0 162.0 163.0 164.0 160.0 164.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.20 (48.9%) stddev-sans-first:38.82 12:00:14 INFO - PROCESS | 4783 | Values: 75.0 81.0 75.0 165.0 76.0 77.0 76.0 75.0 164.0 76.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:87.00 stddev:25.63 (29.5%) stddev-sans-first:26.55 12:00:14 INFO - PROCESS | 4783 | Values: 87.0 87.0 141.0 86.0 87.0 88.0 144.0 86.0 87.0 134.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 12:00:14 INFO - PROCESS | 4783 | Values: 118.0 118.0 118.0 117.0 118.0 120.0 118.0 117.0 118.0 117.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:00:14 INFO - PROCESS | 4783 | Values: 148.0 148.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:00:14 INFO - PROCESS | 4783 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:1.71 (2.7%) stddev-sans-first:0.60 12:00:14 INFO - PROCESS | 4783 | Values: 68.0 62.0 62.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 12:00:14 INFO - PROCESS | 4783 | Values: 65.0 66.0 67.0 66.0 65.0 66.0 66.0 65.0 66.0 65.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:85.00 stddev:7.17 (8.4%) stddev-sans-first:7.47 12:00:14 INFO - PROCESS | 4783 | Values: 84.0 84.0 83.0 87.0 85.0 89.0 91.0 84.0 107.0 85.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:141.00 stddev:8.31 (5.9%) stddev-sans-first:8.80 12:00:14 INFO - PROCESS | 4783 | Values: 143.0 133.0 133.0 139.0 144.0 136.0 139.0 159.0 151.0 136.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.50 stddev:3.16 (1.8%) stddev-sans-first:3.35 12:00:14 INFO - PROCESS | 4783 | Values: 172.0 172.0 179.0 171.0 174.0 174.0 168.0 173.0 172.0 168.0 12:00:14 INFO - PROCESS | 4783 | 12:00:14 INFO - PROCESS | 4783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:3.03 (4.4%) stddev-sans-first:3.17 12:00:14 INFO - PROCESS | 4783 | Values: 68.0 67.0 77.0 71.0 70.0 67.0 68.0 70.0 69.0 67.0 12:00:14 INFO - PROCESS | 4783 | -------- Summary: end -------- 12:00:14 INFO - PROCESS | 4783 | 12:00:15 INFO - TEST-INFO | 4783: exit 0 12:00:15 INFO - TEST-OK | kraken | took 64134ms 12:00:15 INFO - SUITE-END | took 1180s 12:00:15 INFO - Completed test suite (00:19:40) 12:00:15 INFO - javascript benchmark 12:00:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6326.107516077573, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.986625066875, 2694.7305269473045, 2708.4853877763217, 2729.8908043678252, 2743.4101668141348, 4764.976175119124, 4765.428148622166, 4798.808047678093, 4866.586340161081, 4868.878278043051, 4736.881577960544, 4811.711297322163, 4849.709017458955, 4888.584470320027, 4904.0, 4496.595306422413, 4523.389342438762, 4588.678792484528, 4590.288505281686, 4609.262517997121, 413.01705059069235, 4183.27678474276, 4366.301391777316, 4435.112977404516, 4468.642508599304, 4458.799354029076, 4484.506704262529, 4486.753228572427, 4490.797914093873, 4561.384213131218, 4479.0, 4493.820247190109, 4500.054988452429, 4526.298423744325, 4573.451185857685, 4381.802818873159, 4432.955670443319, 4457.375967364572, 4489.775511224459, 4498.280275155992, 4748.762561871893, 4770.0698363819065, 4798.208295631217, 4805.351277577517, 4871.878203044952, 5099.6685215460875, 5277.86805329866, 5281.419043905167, 5299.49654782795, 5352.304200453955, 5234.16253399458, 5279.445658205871, 5281.815136470205, 5287.629865909388, 5298.735063246822, 4900.632452566037, 4904.386951631046, 4916.655834091615, 4920.3111564381015, 4958.752062396866, 5205.115130427836, 5332.06688829461, 5390.407055223922, 5435.456454354612, 5438.211459338374, 5157.716325602128, 5188.8962220755375, 5202.791888324425, 5213.973930130325, 5260.894782104413, 5301.54936830366, 5303.840884773463, 5308.283381743415, 5310.468953104736, 5355.86610334737, 5022.799088036438, 5124.718140502308, 5180.1711726124395, 5252.343457067866, 5268.736563171903, 5083.085044691991, 5092.210707340369, 5106.4382917879, 5133.563647089964, 5155.072087024371, 4349.086691794695, 4349.325854492558, 4370.956290437055, 4410.558944105564, 4430.825831154747, 3761.7554858934627, 3773.415120656303, 3808.0670235791854, 3810.580836108026, 3835.5972622874756, 4332.631726303236, 4378.058717375779, 4378.16814805186, 4395.956040439554, 4481.910361792746, 5202.791888324425, 5205.7397130143345, 5229.947700522946, 5233.319668443154, 5256.6320357574605, 4342.2835232186335, 4447.043885564619, 4487.282034874404, 4491.8203271869415, 4507.233770259064, 4718.0, 4735.289706543977, 4738.691985020962, 4743.549362810528, 4788.377510923558, 4935.555799978019, 4976.676516026447, 4980.103581355391, 4983.37707786534, 5030.044291584587, 5077.466865979019, 5228.085085110167, 5276.419593844597, 5279.47205279469, 5311.893762124659, 4927.852164435073, 4934.062528119646, 4935.210366341368, 4944.950550494449, 4993.201087825931, 5061.291419201389, 5193.195054766517, 5196.038732834438, 5197.064528384927, 5220.9477905220465, 5177.119889618699, 5207.609429292743, 5237.397699264633, 5240.082985477602, 5279.128943724396, 5071.695698258116, 5077.0, 5079.64442489037, 5089.8727531812, 5149.304843846033, 4964.230544265644, 5072.365954255718, 5106.770195341144, 5107.029664363759, 5121.795128194831, 5037.622178336566, 5044.915343201083, 5049.444561098349, 5061.342025536656, 5139.383274007143, 5204.505571970657, 5205.026915690601, 5215.322008139069, 5226.97386513065, 5255.684658920477, 4904.852854414374, 5004.049230646166, 5042.0, 5095.566876815512, 5109.08036553424], "value": 4761.299838850975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.1017114437562, 583.3845293215658, 593.1429084972215, 601.7923816283384, 616.5499185594518, 35405.82297088514, 38253.61746382535, 38394.0, 38804.611953880485, 38943.610563894355, 39014.804925975404, 39710.0, 39832.20335593286, 39940.60059399405, 40203.59796402035, 7678.232176782319, 7827.530348179099, 7886.6845326186885, 7893.999999999971, 7901.249381308767, 7756.340711039568, 7833.569153696544, 7836.2947334739865, 7863.7640870773685, 7901.841963160733, 7806.882896756553, 7875.251851074138, 7879.645415956267, 7882.566458844762, 7930.444868859182, 7795.532268063906, 7850.2542258485355, 7857.214278572125, 7866.72466463671, 7871.173526779691, 7671.0, 7699.230076992256, 7750.883736743954, 7768.495047821873, 7784.104827944746, 36324.27351452956, 36409.45385819215, 36513.26973460516, 36676.26647467036, 36820.44769328462, 2982.9403411931858, 3092.5361195820583, 3127.9061628150966, 3150.4486714824816, 3187.2828613561765, 28254.576181357297, 28722.569161462387, 28791.0, 29318.267043323875, 29334.559981600294, 3278.278778668689, 3397.5073614326034, 3427.4516077427493, 3437.604675462329, 3439.105832483572, 248866.0, 249615.0, 250058.0, 250902.0, 251746.0, 54874.17688734672, 55239.72380138154, 55398.44601554013, 55423.722881386144, 55472.44527554673, 29448.55827162594, 29753.512324384126, 29860.402791944038, 30109.397812043637, 30178.849105754332, 15696.529104126894, 15880.126593037494, 15938.760918585998, 15948.362065517249, 15960.0, 12011.939940300243, 12201.816972745415, 12210.57262995791, 12214.57248996281, 12256.877431225574, 18064.36774712879, 18134.637307253783, 18137.909310453364, 18153.45539633813, 18178.000419953794, 7034.683439245144, 7234.819129521804, 7246.4202863771825, 7320.7071717131785, 7418.851622967511, 785.2814674572816, 860.9956950215209, 893.2095095840228, 909.4952301472614, 964.1370972979145, 27714.3071423212, 28462.288442789097, 28664.186473304657, 28740.712592873802, 29009.41981160365, 919.4621146629163, 943.2783920300975, 948.3788118782209, 966.1691095374226, 982.8967958364269, 14055.156690598596, 14214.218217997903, 14322.78256348222, 14421.134731915909, 14521.201333926525, 390978.0, 391121.0, 393627.0, 393733.0, 394043.0, 48454.75772621185, 49321.0, 49519.75240123848, 49712.751436243314, 49837.0, 1214.5688280660238, 1229.6003798765437, 1233.0320698251828, 1252.2111070026008, 1263.2799304396406, 25683.101091462457, 26865.328366790985, 27068.0, 27329.726702732718, 27377.31556711098, 41234.175316494104, 42087.579124208365, 42192.0, 42255.366169508095, 42364.36453453262, 344805.0, 345032.0, 345717.0, 345739.0, 346859.0, 24798.38004049913, 24801.379965501008, 25227.873860630578, 25230.74769252284, 25358.0, 41347.793261033505, 41358.58641413668, 41519.58480415157, 41750.79124604358, 41976.0, 35882.8205858969, 36415.453768192965, 36626.633733662326, 36680.63319366772, 37021.62978370182, 35858.0, 36278.63721362858, 36300.09249768777, 36467.27065458729, 36533.26933461369, 35540.466892997145, 39334.60665393309, 39476.605233948445, 39816.20367592574, 40254.1949161021, 31919.6808031926, 33548.496772547944, 34007.149821254665, 34088.0, 34109.65890341164, 25636.35909102213, 25879.353016173995, 26195.73804261933, 26407.60388594211, 26670.19989400321], "value": 17408.20152533961, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.50436163360285, 368.85245901639325, 376.570709391294, 388.9941650875239, 393.38435348679315, 16281.592960176002, 16734.58163545912, 17190.22643981021, 17198.656026879456, 17982.417016046697, 10583.10043646291, 11104.944475277613, 11129.944350278238, 11144.665660030212, 11180.161487888421, 4670.2527595584625, 4860.854174374775, 4985.900281994358, 5281.551068159211, 5309.73451327434, 5291.576673866081, 5296.0, 5297.629165958385, 5355.839324820242, 5662.886742265152, 6038.124471951564, 6042.305134909476, 6072.453479186872, 6091.116788065728, 6097.603655762384, 5395.0, 5434.0, 5731.283589551285, 6006.9399306007035, 6071.969640151793, 5250.238715386286, 5273.841784746463, 5278.683279003272, 5283.63014588979, 5287.286216360781, 12340.197887137398, 16243.918780406022, 20137.445424618738, 20724.0, 20777.272795452085, 1707.77798886144, 1798.1368942907347, 1851.5093500222451, 1958.3048017953563, 2033.099052386024, 8936.8659470108, 9104.499252541107, 9156.359054866161, 9244.214241789456, 12714.364281785965, 1627.1457484820446, 1662.9750553741703, 1690.7886514185727, 1697.1514242878561, 1715.2795825753215, 68673.31326686768, 69188.30811691869, 69378.65310673414, 70573.0, 72536.0, 9913.851292230622, 10058.647947321808, 10163.695089147337, 10544.578216871392, 10843.891561084289, 13810.447582096804, 13942.721145577234, 13973.091749036483, 14024.158550487004, 14036.0, 7151.499395042401, 7448.664810083559, 7487.887681684779, 7540.17058123606, 7684.346830519356, 7175.210726820045, 7242.058532390755, 7339.155997060299, 7462.85074298511, 7468.066491688539, 4178.6657067434535, 4327.32926396409, 4407.42703448556, 4431.357453169272, 4473.463184417826, 1794.3988763764023, 1821.1713670279992, 1853.1105069566413, 1873.7283093951573, 1885.3872491440336, 793.3217099380063, 872.5070335260684, 891.7815135291895, 930.4091901642371, 935.9812803743887, 16069.0, 16407.589810254838, 16520.83479165217, 16835.579110522336, 17018.914905425394, 826.6197549127348, 851.2338894994431, 859.0936561927102, 879.7096958003843, 884.9292056635454, 9099.909000910038, 9507.714768556954, 9521.809563808685, 9569.282303827102, 9589.42463452195, 390661.0, 395241.56420815527, 398057.0, 400446.99106017716, 402239.0, 56148.71925640427, 75846.62076689691, 77689.611551943, 78736.60631696804, 78984.0, 879.7360791762574, 892.4912799704236, 897.4794619120894, 913.255696607263, 921.1801496667837, 15254.389824407343, 15321.923390382977, 15441.22793860325, 15464.922675386551, 15982.680346392774, 36130.63869361378, 36743.26513469769, 36788.63211367852, 36819.447708283864, 37056.44415333826, 49073.5092649069, 49781.0, 50770.74614626903, 51276.0, 52133.0, 7579.393648507996, 7591.278828511283, 7599.354054905174, 7646.464747467847, 7671.117821450604, 10717.517711702836, 11729.178957473236, 11850.992665623518, 11904.464299106734, 12331.876681233072, 9244.583993720433, 9790.706278811647, 9875.456849873039, 9917.256205784452, 10234.334768240338, 10653.9467302663, 10664.360138391721, 10759.30064545802, 10859.782804344028, 10861.728456788644, 10019.949900250453, 10036.548355324174, 10148.391096534231, 10572.471376430994, 10670.83993740079, 7692.307692307719, 7879.803004924923, 7915.762527124196, 8115.79710507242, 8115.959420203098, 9280.72157835266, 9519.0, 9920.0, 9978.101970822661, 10530.999555042565], "value": 8138.833420482226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.6301161697957, 1452.0416525093437, 1509.4113295814627, 1677.7231756760127, 1678.5719641491419, 6722.630255335955, 7465.738699145531, 7571.73498927537, 8101.91898081019, 8109.189081091888, 7653.923460765404, 7855.8821617675785, 7938.40461965352, 7939.404544659144, 7955.164707705694, 2200.801927826495, 2224.6218142915745, 2231.944201394962, 2236.552689462114, 2241.8430709850318, 2177.3250292409325, 2194.3746032380773, 2210.734711834582, 2226.554689062186, 2226.5880812049822, 2140.122549754601, 2148.258850696507, 2157.4714195022243, 2158.3201291593177, 2177.6515757478805, 2173.1850556041486, 2183.15948359881, 2183.552371763785, 2183.705199798023, 2187.649976003832, 2159.6976423300753, 2160.0711693971584, 2187.89060546972, 2188.7811218878146, 2192.9890350548303, 7793.688252469894, 7882.448228623941, 7884.881726774103, 7888.013998250219, 7897.368210543143, 4495.797689103998, 4599.218132917378, 4605.0, 4681.157391669498, 4754.952450475485, 2880.6111174991315, 2907.4766542022426, 2985.9850700746356, 2990.8355040472766, 3009.9548506772417, 949.5489642419865, 960.8894977077656, 965.6764983730459, 987.4963768478057, 1004.7889943111956, 10637.46812659364, 10644.095251903598, 10670.73323166927, 10689.679309620646, 10718.732031699192, 4214.30463973441, 4307.870763877088, 4335.1979883721615, 4388.363687265329, 4395.582419670126, 9068.410553314014, 9114.36199466031, 9119.316051296179, 9123.0, 9146.085391460934, 4705.670603057753, 4765.26138448541, 4809.422869255642, 4822.9758851206225, 4832.178529649968, 3592.586852511942, 4188.162367526507, 4322.956770432318, 4385.429894113745, 4430.0, 3604.585472670624, 3607.9278414432088, 3682.0610744260043, 3683.4290684943876, 3814.5803961564206, 1140.2075557487633, 1144.3248483394837, 1157.2304417562395, 1159.8492196014633, 1161.3902701082, 817.345218977927, 829.3738227638215, 831.7130589946458, 831.9875201871977, 833.0045595513425, 4962.751862406937, 4969.676970996946, 4978.228374601942, 5068.0, 5083.212102124176, 407.95512493625677, 410.517641770918, 411.475368904649, 420.48910573652546, 424.3232044888398, 3876.5348158221195, 3985.80070996449, 4004.0, 4024.2555127300957, 4067.8169482373364, 9766.75583110428, 9898.208143348515, 9963.551640176209, 9973.351732137387, 10002.899971000197, 9840.803183936425, 9855.45794981283, 10021.79956400868, 10041.297109202433, 10049.748756281151, 7445.255474452511, 7636.923630763732, 7644.961775191088, 7649.847003059907, 7682.501912127082, 5391.353037635509, 5455.8363249102595, 5577.581681373995, 5585.832425027255, 5664.85837854057, 8888.555572221492, 9035.232005279362, 9144.131307525775, 9150.993390726882, 9194.586243619187, 8916.55417229149, 9180.678676246567, 9422.057794220524, 9429.481378524248, 9461.905380946102, 6555.180602424697, 6583.604983700993, 6699.0, 6709.630970296681, 6743.055972163803, 7522.0, 7590.96204518996, 7602.201768814416, 7611.2769286917655, 7671.079470463357, 6667.966660166668, 6784.084148640068, 6834.077399550997, 6858.965705171442, 6885.311468853275, 6674.866502670016, 6737.3599508046655, 6786.660666966731, 6824.385805277549, 6888.242293347828, 6337.936620633919, 6364.331745166691, 6391.6804159792755, 6395.360463953567, 6406.359364063556, 4457.665675074318, 4473.821047158207, 4557.977210113928, 4591.357209990537, 4631.768411579475, 4527.547245275446, 4548.226801443696, 4578.153041687298, 4595.609373203315, 4655.4180727409075], "value": 4115.206844660193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.88839296870714, 297.9791414600978, 302.6413699765778, 303.45681230597233, 308.4278663079988, 4876.43920949091, 4898.559129678329, 4928.728919909404, 5020.698758074518, 5035.924461133086, 4950.3317052197945, 4976.527229913152, 4983.127952608297, 5007.4491805901325, 5020.824271150511, 3932.213557288547, 3935.7048221383366, 3943.881683549498, 3946.3291240489184, 3967.3453880109746, 3690.24350008249, 3950.308695978192, 3969.6701604962373, 3982.1637456134245, 4005.6194661507257, 3808.8286027128706, 3828.157805282847, 3834.78908660025, 3843.2889915365745, 3859.459675645412, 3834.2331533693373, 3848.749831260973, 3859.9228015439535, 3875.1087249932393, 3879.941800872989, 3327.467605183159, 3346.113279980807, 3378.932421351584, 3391.5082313064468, 3401.6598340166033, 4655.557722016403, 4723.433188017426, 4765.189917713997, 4771.23660214364, 4772.928406073912, 4331.436913201295, 4368.366586844922, 4402.547159437378, 4413.624841888443, 4415.337699345092, 5121.564667003272, 5149.845504634867, 5157.123289040835, 5176.870578235536, 5210.583153347761, 3602.2975519773654, 3685.3366394049062, 3697.5932647408763, 3699.204670995749, 3703.370427027412, 5423.186522021729, 5441.265429167091, 5446.91829622556, 5487.807926722546, 5513.283273174462, 3729.850805967785, 3742.6631603155847, 3744.8689295874515, 3753.436984452354, 3777.017066040296, 3781.5840257571645, 3784.905377365533, 3786.2995345861104, 3790.166163444038, 3820.426935959573, 4293.8711838644895, 4351.19502891966, 4358.777023717927, 4370.956290437055, 4373.584509471595, 5220.869478263074, 5223.869403264873, 5244.187150991603, 5247.7667748079175, 5266.183741520071, 1232.9136960412864, 1272.8727127287382, 1310.1484035377082, 1310.4758096761373, 1313.2973858985397, 809.2635701511596, 829.8340331933516, 838.3209600223838, 841.8232171243985, 842.4902933725131, 4033.1933613276874, 4036.717429779946, 4044.211378781168, 4065.3495440729935, 4075.2053349596545, 4758.238681810963, 4759.76201189946, 4776.95223047772, 4814.614830813526, 4835.8065677372515, 4006.117124951268, 4042.3532234842282, 4070.9796451017555, 4083.8967931515294, 4089.488813898263, 2501.287133167075, 2674.2244749022566, 2877.2662970942692, 2882.875678485392, 2895.4798730666566, 5070.783012077075, 5077.695338279641, 5080.974595127001, 5103.464136265713, 5117.565006974449, 5261.4738526147075, 5526.778928842801, 5538.944610553924, 5559.471850174227, 5559.722013899289, 5040.218766091261, 5040.36995375578, 5042.42012168598, 5116.411612664591, 5117.616178786606, 5372.409035006068, 5382.542483888913, 5419.945800541944, 5426.213199086032, 5444.128939369682, 5116.334876466036, 5241.659292145999, 5251.212318152155, 5272.762725677277, 5291.814786482455, 5101.495058957542, 5107.974460127824, 5128.30765847277, 5142.97428512855, 5150.356205474316, 3717.368047431997, 3729.9929019165215, 3739.9065023373546, 3746.3443897317316, 3746.4380342948775, 5168.612354073384, 5326.9200961984825, 5333.7866485340155, 5338.919916201183, 5425.131978883517, 5161.535461808456, 5168.767405466839, 5175.585953123666, 5190.532852043183, 5193.143131383431, 5137.6660517066275, 5161.458046905021, 5173.508516690908, 5184.351956005499, 5196.220022288057, 5018.197088465828, 5099.801546636463, 5107.599428268708, 5122.257272695364, 5151.845444636667, 5216.7130807804415, 5226.63413561047, 5234.947650523446, 5238.895222095613, 5242.842714718565, 5115.872103197301, 5118.846434606968, 5151.922721159111, 5154.273318438215, 5159.17453207485], "value": 3867.6099706092928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.829120283125, 656.924453687826, 666.1739443090569, 740.8259059121106, 768.6809973860846, 11989.160758746892, 12799.680007999805, 12847.164934279266, 12861.164024338423, 12886.935565322172, 11393.715157121076, 11414.771704565903, 11438.885611143885, 11484.827727584094, 13693.931530342334, 802.9959850200755, 804.8309854930471, 806.5523634382915, 806.9757907262791, 807.0436532708729, 629.527854109418, 787.0791174326052, 809.9635516401776, 815.384384789486, 816.3673153306205, 854.0775961961067, 857.2413414128509, 858.1975852577829, 858.8325276571071, 859.6131740716671, 825.3438516379492, 830.8587540118194, 832.675256649907, 832.6794184239081, 834.4867906237681, 606.7178761875705, 606.7754930675678, 607.0317843040343, 609.0194786393902, 610.4749915073033, 13298.069135160446, 13408.731825363535, 13452.461901523928, 13468.326583670876, 13469.461221551126, 13566.59300220995, 13744.244066576335, 13752.587422377344, 13875.861241387558, 13905.096168749, 10139.797204055878, 10226.846597301046, 10290.279680422373, 10411.583536658525, 10506.947465262625, 3405.744569157323, 3421.349943510725, 3422.3668621305137, 3422.3668621305137, 3423.880164194266, 57508.71245643787, 57518.13722794162, 58451.70774146102, 58705.41294587042, 59138.40861591372, 10766.892331076746, 10815.729606759895, 10890.29213101146, 10913.126949843994, 11081.72295692598, 19983.300584479475, 20051.398458046282, 20076.89961550183, 20106.69839952402, 20132.89933550352, 6796.349184158506, 7001.649917504104, 7110.502264841515, 7218.927810721931, 7276.890846637305, 3674.6325367463573, 3687.649673281034, 3717.8326975285636, 3776.4335349697767, 3854.71089668276, 2739.7123302052996, 2858.742713155826, 2862.4561333347015, 2867.068202834087, 2874.0228322370494, 515.1294312611674, 516.4886762105489, 521.0048806779034, 521.2259794205602, 522.1306524636514, 478.92097803861975, 492.2861850316983, 498.95468992460735, 507.1783710389193, 507.28219569309016, 6824.146981627297, 6857.451403887677, 6908.861822763517, 6952.965235173791, 7070.646467676595, 382.32328778062674, 417.31768558407225, 456.08099679146545, 469.58207195595946, 470.28751441566055, 3410.1645096951406, 3481.617022127564, 3484.094135524731, 3555.7333200010103, 3569.714422846166, 54716.0, 54955.45044549583, 55290.0, 55350.72324638351, 70687.0, 51918.0, 77148.61425692835, 78042.60978695184, 79350.6032469834, 81305.0, 67880.3211967874, 68631.65684171548, 68729.63518240879, 69594.0, 70860.64569677222, 6545.901811472927, 6612.768553100618, 6631.701573429304, 6668.233153187445, 6693.598384096969, 42464.39548287084, 44031.0, 44105.11789764251, 44751.32873006973, 44924.55075449334, 58214.708926455096, 60437.0, 60878.39121608727, 61518.0, 61560.69219653873, 9190.862137068083, 9203.677871274473, 9270.629174832931, 9348.345615806827, 9478.241740660593, 9182.586783594888, 9319.673811416567, 9517.714468565953, 9540.093691099335, 9659.034096590285, 8530.445521041112, 8538.530380829114, 8542.572871356531, 8573.485590864568, 8621.137886211329, 8687.0, 8802.163794439519, 8941.37410381293, 8978.551072446482, 9030.413023153475, 8310.916890831015, 8374.581270936307, 8437.578121094044, 8504.787380315542, 8589.098144694717, 7494.925050749423, 7674.270944260286, 7737.806554836174, 7779.37764978789, 7924.326432253092, 7474.327310542078, 7525.285097915689, 7707.306342429209, 7786.7663970080985, 7818.413618978713], "value": 5968.91357585637, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 113.0, 114.0, 115.0, 112.0, 113.0, 113.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 138.0, 159.0, 184.0, 135.0, 161.0, 162.0, 139.0, 214.0, 135.0], "value": 159.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 174.0, 163.0, 162.0, 163.0, 164.0, 160.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 75.0, 165.0, 76.0, 77.0, 76.0, 75.0, 164.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 141.0, 86.0, 87.0, 88.0, 144.0, 86.0, 87.0, 134.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 120.0, 118.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 87.0, 85.0, 89.0, 91.0, 84.0, 107.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 133.0, 139.0, 144.0, 136.0, 139.0, 159.0, 151.0, 136.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 179.0, 171.0, 174.0, 174.0, 168.0, 173.0, 172.0, 168.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 77.0, 71.0, 70.0, 67.0, 68.0, 70.0, 69.0, 67.0], "value": 69.4, "unit": "score"}]}]} 12:00:15 INFO - Return code: 0 12:00:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:16 ERROR - # TBPL SUCCESS # 12:00:16 INFO - Running post-action listener: _resource_record_post_action 12:00:16 INFO - ##### 12:00:16 INFO - ##### Finished run-tests step (success) 12:00:16 INFO - ##### 12:00:16 INFO - Running post-run listener: _resource_record_post_run 12:00:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284049408; Read time: 16; Write time: 205508 12:00:16 INFO - TinderboxPrint: CPU usage
13.4% 12:00:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:00:16 INFO - TinderboxPrint: I/O write bytes / time
284,049,408 / 205,508 12:00:16 INFO - TinderboxPrint: CPU idle
8,267.6 (86.6%) 12:00:16 INFO - TinderboxPrint: CPU user
1,232.3 (12.9%) 12:00:16 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1224704; Read time: 0; Write time: 264 12:00:16 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282824704; Read time: 16; Write time: 205244 12:00:16 INFO - Running post-run listener: _upload_blobber_files 12:00:16 INFO - Blob upload gear active. 12:00:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:00:17 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:00:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:17 INFO - (blobuploader) - INFO - Done attempting. 12:00:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:22 INFO - (blobuploader) - INFO - Done attempting. 12:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:00:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:23 INFO - (blobuploader) - INFO - Done attempting. 12:00:23 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:23 INFO - Return code: 0 12:00:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f80f4a0a2d483a683bc8e6d498aaf7f8607aa6903022a1a3e30502083efec56004d5f42a4a514634532f8d4f76f8d034164339614d9592c1d559b9e239ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e978c85c6efda66ff36a8b3fc0da69ac38e0a59e40d9aa37c6b85587fa11028840fc1a7b0e1659cb6654b6970e652c5d9caf303dd8adaf1667f0bec72906c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2926828baa696d84ff42f0a26449729fea888e1d522381a59510126271bfdc5818d8162140a591518d52646dd6808084a106b8aaa089a14846fa229c4ba54f42"} 12:00:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:23 INFO - Contents: 12:00:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f80f4a0a2d483a683bc8e6d498aaf7f8607aa6903022a1a3e30502083efec56004d5f42a4a514634532f8d4f76f8d034164339614d9592c1d559b9e239ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e978c85c6efda66ff36a8b3fc0da69ac38e0a59e40d9aa37c6b85587fa11028840fc1a7b0e1659cb6654b6970e652c5d9caf303dd8adaf1667f0bec72906c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2926828baa696d84ff42f0a26449729fea888e1d522381a59510126271bfdc5818d8162140a591518d52646dd6808084a106b8aaa089a14846fa229c4ba54f42"} 12:00:23 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:23 INFO - Copying logs to upload dir... 12:00:23 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.225579 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-08 12:00:23.158926) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 12:00:23.163064) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d5f80f4a0a2d483a683bc8e6d498aaf7f8607aa6903022a1a3e30502083efec56004d5f42a4a514634532f8d4f76f8d034164339614d9592c1d559b9e239ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e978c85c6efda66ff36a8b3fc0da69ac38e0a59e40d9aa37c6b85587fa11028840fc1a7b0e1659cb6654b6970e652c5d9caf303dd8adaf1667f0bec72906c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2926828baa696d84ff42f0a26449729fea888e1d522381a59510126271bfdc5818d8162140a591518d52646dd6808084a106b8aaa089a14846fa229c4ba54f42"} build_url:https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/Sayg7R8RRdSQ6juoWEcBRA/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/Fx-Team-Non-PGO/sha512/6d5f80f4a0a2d483a683bc8e6d498aaf7f8607aa6903022a1a3e30502083efec56004d5f42a4a514634532f8d4f76f8d034164339614d9592c1d559b9e239ffa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9e978c85c6efda66ff36a8b3fc0da69ac38e0a59e40d9aa37c6b85587fa11028840fc1a7b0e1659cb6654b6970e652c5d9caf303dd8adaf1667f0bec72906c68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2926828baa696d84ff42f0a26449729fea888e1d522381a59510126271bfdc5818d8162140a591518d52646dd6808084a106b8aaa089a14846fa229c4ba54f42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 12:00:23.191786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 12:00:23.192369) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465410831.87430-2080029138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 12:00:23.274702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 12:00:23.275022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 12:00:23.275322) ========= ========= Total master_lag: 0.21 =========