builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1465515432.59 results: success (0) buildid: 20160609160129 builduid: c2470b5c4cd3408eb951ea7aa37d6172 revision: 880822ee2a0d1e9a847d2f1625964427313fc47a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.592951) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.593489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.593818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.609292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.609613) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:37:12-- 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% 219M=0s 2016-06-09 16:37:12 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085600 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.710815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.711355) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020313 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.761864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:12.762294) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 880822ee2a0d1e9a847d2f1625964427313fc47a --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 880822ee2a0d1e9a847d2f1625964427313fc47a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:37:12,781 truncating revision to first 12 chars 2016-06-09 16:37:12,781 Setting DEBUG logging. 2016-06-09 16:37:12,781 attempt 1/10 2016-06-09 16:37:12,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/880822ee2a0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:37:13,092 unpacking tar archive at: fx-team-880822ee2a0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683068 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:13.464941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:13.465326) ========= script_repo_revision: 880822ee2a0d1e9a847d2f1625964427313fc47a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:13.465810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:13.466119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:37:13.477927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 16:37:13.478238) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:13 INFO - MultiFileLogger online at 20160609 16:37:13 in /builds/slave/test 16:37:13 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 16:37:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:13 INFO - {'append_to_log': False, 16:37:13 INFO - 'base_work_dir': '/builds/slave/test', 16:37:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:37:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:13 INFO - 'branch': 'Fx-Team-Non-PGO', 16:37:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:13 INFO - 'config_files': ('talos/linux_config.py',), 16:37:13 INFO - 'default_actions': ('clobber', 16:37:13 INFO - 'read-buildbot-config', 16:37:13 INFO - 'download-and-extract', 16:37:13 INFO - 'populate-webroot', 16:37:13 INFO - 'create-virtualenv', 16:37:13 INFO - 'install', 16:37:13 INFO - 'run-tests'), 16:37:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:13 INFO - 'download_minidump_stackwalk': True, 16:37:13 INFO - 'download_symbols': 'ondemand', 16:37:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:13 INFO - 'installer_path': 'installer.exe', 16:37:13 INFO - 'log_level': 'info', 16:37:13 INFO - 'log_name': 'talos', 16:37:13 INFO - 'log_to_console': True, 16:37:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:13 INFO - 'opt_config_files': (), 16:37:13 INFO - 'pip_index': False, 16:37:13 INFO - 'sps_profile': False, 16:37:13 INFO - 'sps_profile_interval': 0, 16:37:13 INFO - 'suite': 'dromaeojs-e10s', 16:37:13 INFO - 'system_bits': '32', 16:37:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:13 INFO - 'title': 'talos-linux64-ix-005', 16:37:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:13 INFO - 'use_talos_json': True, 16:37:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:13 INFO - 'work_dir': 'build'} 16:37:13 INFO - ##### 16:37:13 INFO - ##### Running clobber step. 16:37:13 INFO - ##### 16:37:13 INFO - Running pre-action listener: _resource_record_pre_action 16:37:13 INFO - Running main action method: clobber 16:37:13 INFO - rmtree: /builds/slave/test/build 16:37:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:37:14 INFO - Running post-action listener: _resource_record_post_action 16:37:14 INFO - ##### 16:37:14 INFO - ##### Finished clobber step (success) 16:37:14 INFO - ##### 16:37:14 INFO - ##### 16:37:14 INFO - ##### Running read-buildbot-config step. 16:37:14 INFO - ##### 16:37:14 INFO - Running pre-action listener: _resource_record_pre_action 16:37:14 INFO - Running main action method: read_buildbot_config 16:37:14 INFO - Using buildbot properties: 16:37:14 INFO - { 16:37:14 INFO - "project": "", 16:37:14 INFO - "product": "firefox", 16:37:14 INFO - "script_repo_revision": "production", 16:37:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:37:14 INFO - "repository": "", 16:37:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 16:37:14 INFO - "buildid": "20160609160129", 16:37:14 INFO - "pgo_build": "False", 16:37:14 INFO - "basedir": "/builds/slave/test", 16:37:14 INFO - "buildnumber": 1395, 16:37:14 INFO - "slavename": "talos-linux64-ix-005", 16:37:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:37:14 INFO - "platform": "ubuntu64_hw", 16:37:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:37:14 INFO - "branch": "fx-team", 16:37:14 INFO - "repo_path": "integration/fx-team", 16:37:14 INFO - "revision": "880822ee2a0d1e9a847d2f1625964427313fc47a", 16:37:14 INFO - "stage_platform": "linux64", 16:37:14 INFO - "builduid": "c2470b5c4cd3408eb951ea7aa37d6172", 16:37:14 INFO - "slavebuilddir": "test" 16:37:14 INFO - } 16:37:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:37:14 INFO - Running post-action listener: _resource_record_post_action 16:37:14 INFO - ##### 16:37:14 INFO - ##### Finished read-buildbot-config step (success) 16:37:14 INFO - ##### 16:37:14 INFO - ##### 16:37:14 INFO - ##### Running download-and-extract step. 16:37:14 INFO - ##### 16:37:14 INFO - Running pre-action listener: _resource_record_pre_action 16:37:14 INFO - Running main action method: download_and_extract 16:37:14 INFO - mkdir: /builds/slave/test/build/tests 16:37: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')]} 16:37:14 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:15 INFO - Downloaded 1361 bytes. 16:37:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:37:15 INFO - Using the following test package requirements: 16:37:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:37:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:37:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:37:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'jsshell-linux-x86_64.zip'], 16:37:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:37:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:37:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:37:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:37:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:37:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:37:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:37:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:15 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:16 INFO - Downloaded 22880050 bytes. 16:37:16 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'] 16:37:16 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 16:37:17 INFO - Return code: 0 16:37:17 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 16:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:17 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:18 INFO - Downloaded 22880050 bytes. 16:37:18 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'] 16:37:18 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 16:37:20 INFO - Return code: 0 16:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:20 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:21 INFO - Downloaded 10833377 bytes. 16:37:21 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'] 16:37:21 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 16:37:21 INFO - Return code: 0 16:37:21 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')]} 16:37:21 INFO - https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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 16:37:22 INFO - Downloaded 55379494 bytes. 16:37:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:37:22 INFO - mkdir: /builds/slave/test/properties 16:37:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:37:22 INFO - Writing to file /builds/slave/test/properties/build_url 16:37:22 INFO - Contents: 16:37:22 INFO - build_url:https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:37:23 INFO - Running post-action listener: _resource_record_post_action 16:37:23 INFO - Running post-action listener: set_extra_try_arguments 16:37:23 INFO - ##### 16:37:23 INFO - ##### Finished download-and-extract step (success) 16:37:23 INFO - ##### 16:37:23 INFO - ##### 16:37:23 INFO - ##### Running populate-webroot step. 16:37:23 INFO - ##### 16:37:23 INFO - Running pre-action listener: _resource_record_pre_action 16:37:23 INFO - Running main action method: populate_webroot 16:37:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:37:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:37:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:37:23 INFO - '--tppagecycles', 16:37:23 INFO - '7'], 16:37:23 INFO - 'tests': ['tsvgm']}}, 16:37:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:37:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:37:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:37:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:37:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:37:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['damp', 'tps']}, 16:37:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['damp', 'tps']}, 16:37:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['dromaeo_dom']}, 16:37:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:37:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['a11yr', 16:37:23 INFO - 'ts_paint', 16:37:23 INFO - 'tpaint', 16:37:23 INFO - 'sessionrestore', 16:37:23 INFO - 'sessionrestore_no_auto_restore', 16:37:23 INFO - 'tabpaint']}, 16:37:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['tsvgx', 16:37:23 INFO - 'tsvgr_opacity', 16:37:23 INFO - 'tart', 16:37:23 INFO - 'tscrollx', 16:37:23 INFO - 'cart']}, 16:37:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:37:23 INFO - 'tsvgr_opacity', 16:37:23 INFO - 'tart', 16:37:23 INFO - 'tscrollx', 16:37:23 INFO - 'cart']}, 16:37:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--disable-e10s'], 16:37:23 INFO - 'tests': ['tp5o']}, 16:37:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'tests': ['tp5o']}, 16:37:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--disable-e10s', 16:37:23 INFO - '--xperf_path', 16:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:23 INFO - 'tests': ['tp5n']}, 16:37:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:37:23 INFO - 'talos_options': ['--xperf_path', 16:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:37:23 INFO - 'tests': ['tp5n']}}, 16:37:23 INFO - 'talos.zip': {'path': '', 16:37:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:37:23 INFO - Running post-action listener: _resource_record_post_action 16:37:23 INFO - ##### 16:37:23 INFO - ##### Finished populate-webroot step (success) 16:37:23 INFO - ##### 16:37:23 INFO - ##### 16:37:23 INFO - ##### Running create-virtualenv step. 16:37:23 INFO - ##### 16:37:23 INFO - Running pre-action listener: _resource_record_pre_action 16:37:23 INFO - Running main action method: create_virtualenv 16:37:23 INFO - Creating virtualenv /builds/slave/test/build/venv 16:37:23 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 16:37:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:37:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:37:23 INFO - Using real prefix '/usr' 16:37:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:37:24 INFO - Installing distribute.............................................................................................................................................................................................done. 16:37:26 INFO - Installing pip.................done. 16:37:26 INFO - Return code: 0 16:37:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:26 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 16:37:26 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 16:37:26 INFO - Using env: {'DISPLAY': ':0', 16:37:26 INFO - 'HOME': '/home/cltbld', 16:37:26 INFO - 'LANG': 'en_US.UTF-8', 16:37:26 INFO - 'LANGUAGE': 'en_US:en', 16:37:26 INFO - 'LOGNAME': 'cltbld', 16:37:26 INFO - 'MAIL': '/var/mail/cltbld', 16:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:26 INFO - 'MOZ_NO_REMOTE': '1', 16:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:26 INFO - 'NO_EM_RESTART': '1', 16:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:26 INFO - 'PWD': '/builds/slave/test', 16:37:26 INFO - 'SHELL': '/bin/bash', 16:37:26 INFO - 'SHLVL': '1', 16:37:26 INFO - 'TERM': 'linux', 16:37:26 INFO - 'TMOUT': '86400', 16:37:26 INFO - 'USER': 'cltbld', 16:37:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:26 INFO - '_': '/tools/buildbot/bin/python'} 16:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:26 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 16:37:26 INFO - Cleaning up... 16:37:26 INFO - Return code: 0 16:37:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:26 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:26 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 16:37:26 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 16:37:26 INFO - Using env: {'DISPLAY': ':0', 16:37:26 INFO - 'HOME': '/home/cltbld', 16:37:26 INFO - 'LANG': 'en_US.UTF-8', 16:37:26 INFO - 'LANGUAGE': 'en_US:en', 16:37:26 INFO - 'LOGNAME': 'cltbld', 16:37:26 INFO - 'MAIL': '/var/mail/cltbld', 16:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:26 INFO - 'MOZ_NO_REMOTE': '1', 16:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:26 INFO - 'NO_EM_RESTART': '1', 16:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:26 INFO - 'PWD': '/builds/slave/test', 16:37:26 INFO - 'SHELL': '/bin/bash', 16:37:26 INFO - 'SHLVL': '1', 16:37:26 INFO - 'TERM': 'linux', 16:37:26 INFO - 'TMOUT': '86400', 16:37:26 INFO - 'USER': 'cltbld', 16:37:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:26 INFO - '_': '/tools/buildbot/bin/python'} 16:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:26 INFO - Downloading/unpacking psutil>=3.1.1 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:26 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 16:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:37:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:28 INFO - Installing collected packages: psutil 16:37:28 INFO - Running setup.py install for psutil 16:37:28 INFO - building 'psutil._psutil_linux' extension 16:37:28 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 16:37:29 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 16:37:29 INFO - building 'psutil._psutil_posix' extension 16:37:29 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 16:37:29 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 16:37:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:37:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:37:29 INFO - Successfully installed psutil 16:37:29 INFO - Cleaning up... 16:37:29 INFO - Return code: 0 16:37:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:37:29 INFO - Using env: {'DISPLAY': ':0', 16:37:29 INFO - 'HOME': '/home/cltbld', 16:37:29 INFO - 'LANG': 'en_US.UTF-8', 16:37:29 INFO - 'LANGUAGE': 'en_US:en', 16:37:29 INFO - 'LOGNAME': 'cltbld', 16:37:29 INFO - 'MAIL': '/var/mail/cltbld', 16:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:29 INFO - 'MOZ_NO_REMOTE': '1', 16:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:29 INFO - 'NO_EM_RESTART': '1', 16:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:29 INFO - 'PWD': '/builds/slave/test', 16:37:29 INFO - 'SHELL': '/bin/bash', 16:37:29 INFO - 'SHLVL': '1', 16:37:29 INFO - 'TERM': 'linux', 16:37:29 INFO - 'TMOUT': '86400', 16:37:29 INFO - 'USER': 'cltbld', 16:37:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:29 INFO - '_': '/tools/buildbot/bin/python'} 16:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:29 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 16:37:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:37:31 INFO - Installing collected packages: mozsystemmonitor 16:37:31 INFO - Running setup.py install for mozsystemmonitor 16:37:31 INFO - Successfully installed mozsystemmonitor 16:37:31 INFO - Cleaning up... 16:37:32 INFO - Return code: 0 16:37:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:37:32 INFO - Using env: {'DISPLAY': ':0', 16:37:32 INFO - 'HOME': '/home/cltbld', 16:37:32 INFO - 'LANG': 'en_US.UTF-8', 16:37:32 INFO - 'LANGUAGE': 'en_US:en', 16:37:32 INFO - 'LOGNAME': 'cltbld', 16:37:32 INFO - 'MAIL': '/var/mail/cltbld', 16:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:32 INFO - 'MOZ_NO_REMOTE': '1', 16:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:32 INFO - 'NO_EM_RESTART': '1', 16:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:32 INFO - 'PWD': '/builds/slave/test', 16:37:32 INFO - 'SHELL': '/bin/bash', 16:37:32 INFO - 'SHLVL': '1', 16:37:32 INFO - 'TERM': 'linux', 16:37:32 INFO - 'TMOUT': '86400', 16:37:32 INFO - 'USER': 'cltbld', 16:37:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:32 INFO - '_': '/tools/buildbot/bin/python'} 16:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:32 INFO - Downloading/unpacking jsonschema==2.5.1 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:37:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:37:34 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 16:37:34 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 16:37:34 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 16:37:34 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 16:37:34 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 16:37:34 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 16:37:34 INFO - Downloading functools32-3.2.3-2.tar.gz 16:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:37:34 INFO - warning: no files found matching '*.txt' 16:37:34 INFO - no previously-included directories found matching 'build' 16:37:34 INFO - no previously-included directories found matching 'dist' 16:37:34 INFO - no previously-included directories found matching '.git*' 16:37:34 INFO - Installing collected packages: jsonschema, functools32 16:37:34 INFO - Running setup.py install for functools32 16:37:35 INFO - warning: no files found matching '*.txt' 16:37:35 INFO - no previously-included directories found matching 'build' 16:37:35 INFO - no previously-included directories found matching 'dist' 16:37:35 INFO - no previously-included directories found matching '.git*' 16:37:35 INFO - Successfully installed jsonschema functools32 16:37:35 INFO - Cleaning up... 16:37:35 INFO - Return code: 0 16:37:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:37:35 INFO - Using env: {'DISPLAY': ':0', 16:37:35 INFO - 'HOME': '/home/cltbld', 16:37:35 INFO - 'LANG': 'en_US.UTF-8', 16:37:35 INFO - 'LANGUAGE': 'en_US:en', 16:37:35 INFO - 'LOGNAME': 'cltbld', 16:37:35 INFO - 'MAIL': '/var/mail/cltbld', 16:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:35 INFO - 'MOZ_NO_REMOTE': '1', 16:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:35 INFO - 'NO_EM_RESTART': '1', 16:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:35 INFO - 'PWD': '/builds/slave/test', 16:37:35 INFO - 'SHELL': '/bin/bash', 16:37:35 INFO - 'SHLVL': '1', 16:37:35 INFO - 'TERM': 'linux', 16:37:35 INFO - 'TMOUT': '86400', 16:37:35 INFO - 'USER': 'cltbld', 16:37:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:35 INFO - '_': '/tools/buildbot/bin/python'} 16:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:37:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:37:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:37 INFO - Downloading docopt-0.6.1.tar.gz 16:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:37:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:37:38 INFO - Running setup.py install for blobuploader 16:37:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:37:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:37:38 INFO - Running setup.py install for requests 16:37:38 INFO - Running setup.py install for docopt 16:37:38 INFO - Successfully installed blobuploader requests docopt 16:37:38 INFO - Cleaning up... 16:37:38 INFO - Return code: 0 16:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:38 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:38 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 16:37:38 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 16:37:38 INFO - Using env: {'DISPLAY': ':0', 16:37:38 INFO - 'HOME': '/home/cltbld', 16:37:38 INFO - 'LANG': 'en_US.UTF-8', 16:37:38 INFO - 'LANGUAGE': 'en_US:en', 16:37:38 INFO - 'LOGNAME': 'cltbld', 16:37:38 INFO - 'MAIL': '/var/mail/cltbld', 16:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:38 INFO - 'MOZ_NO_REMOTE': '1', 16:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:38 INFO - 'NO_EM_RESTART': '1', 16:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:38 INFO - 'PWD': '/builds/slave/test', 16:37:38 INFO - 'SHELL': '/bin/bash', 16:37:38 INFO - 'SHLVL': '1', 16:37:38 INFO - 'TERM': 'linux', 16:37:38 INFO - 'TMOUT': '86400', 16:37:38 INFO - 'USER': 'cltbld', 16:37:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:38 INFO - '_': '/tools/buildbot/bin/python'} 16:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:38 INFO - Running setup.py (path:/tmp/pip-lEpHLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:38 INFO - Running setup.py (path:/tmp/pip-0AaIrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:38 INFO - Running setup.py (path:/tmp/pip-9JMF7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:39 INFO - Running setup.py (path:/tmp/pip-QpUWE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:39 INFO - Running setup.py (path:/tmp/pip-NmMOMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:39 INFO - Running setup.py (path:/tmp/pip-JgySUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:39 INFO - Running setup.py (path:/tmp/pip-wtspiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:39 INFO - Running setup.py (path:/tmp/pip-kHRTFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:39 INFO - Running setup.py (path:/tmp/pip-40eEIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:39 INFO - Running setup.py (path:/tmp/pip-hU7ezE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:39 INFO - Running setup.py (path:/tmp/pip-cSIo5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:39 INFO - Running setup.py (path:/tmp/pip-7dlJch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:39 INFO - Running setup.py (path:/tmp/pip-GoGX3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:39 INFO - Running setup.py (path:/tmp/pip-VkNe1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:39 INFO - Running setup.py (path:/tmp/pip-pqUQ9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:39 INFO - Running setup.py (path:/tmp/pip-033QgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:39 INFO - Running setup.py (path:/tmp/pip-PPbN6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:37:40 INFO - Running setup.py install for manifestparser 16:37:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Running setup.py install for mozcrash 16:37:40 INFO - Running setup.py install for mozdebug 16:37:40 INFO - Running setup.py install for mozdevice 16:37:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Running setup.py install for mozfile 16:37:40 INFO - Running setup.py install for mozhttpd 16:37:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Running setup.py install for mozinfo 16:37:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Running setup.py install for mozInstall 16:37:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:37:40 INFO - Running setup.py install for mozleak 16:37:40 INFO - Running setup.py install for mozlog 16:37:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Running setup.py install for moznetwork 16:37:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Running setup.py install for mozprocess 16:37:41 INFO - Running setup.py install for mozprofile 16:37:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Running setup.py install for mozrunner 16:37:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Running setup.py install for mozscreenshot 16:37:41 INFO - Running setup.py install for moztest 16:37:41 INFO - Running setup.py install for mozversion 16:37:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:37:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:37:41 INFO - Cleaning up... 16:37:41 INFO - Return code: 0 16:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:41 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:41 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 16:37:41 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 16:37:41 INFO - Using env: {'DISPLAY': ':0', 16:37:41 INFO - 'HOME': '/home/cltbld', 16:37:41 INFO - 'LANG': 'en_US.UTF-8', 16:37:41 INFO - 'LANGUAGE': 'en_US:en', 16:37:41 INFO - 'LOGNAME': 'cltbld', 16:37:41 INFO - 'MAIL': '/var/mail/cltbld', 16:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:41 INFO - 'MOZ_NO_REMOTE': '1', 16:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:41 INFO - 'NO_EM_RESTART': '1', 16:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:41 INFO - 'PWD': '/builds/slave/test', 16:37:41 INFO - 'SHELL': '/bin/bash', 16:37:41 INFO - 'SHLVL': '1', 16:37:41 INFO - 'TERM': 'linux', 16:37:41 INFO - 'TMOUT': '86400', 16:37:41 INFO - 'USER': 'cltbld', 16:37:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:41 INFO - '_': '/tools/buildbot/bin/python'} 16:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:37:42 INFO - Running setup.py (path:/tmp/pip-SFBUCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:37:42 INFO - Running setup.py (path:/tmp/pip-ITyoAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:37:42 INFO - Running setup.py (path:/tmp/pip-hvjGZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:37:42 INFO - Running setup.py (path:/tmp/pip-OQi2bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:37:42 INFO - Running setup.py (path:/tmp/pip-9Q2Cvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:42 INFO - Running setup.py (path:/tmp/pip-_11sIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:42 INFO - Running setup.py (path:/tmp/pip-lqyDcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:42 INFO - Running setup.py (path:/tmp/pip-tgpGL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:42 INFO - Running setup.py (path:/tmp/pip-rdsSU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:42 INFO - Running setup.py (path:/tmp/pip-NUDBxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:42 INFO - Running setup.py (path:/tmp/pip-fhqsEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:42 INFO - Running setup.py (path:/tmp/pip-swvx2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:42 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)) 16:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:42 INFO - Running setup.py (path:/tmp/pip-VBEkmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:43 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)) 16:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:43 INFO - Running setup.py (path:/tmp/pip-m1zSf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:43 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)) 16:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:43 INFO - Running setup.py (path:/tmp/pip-ZCuS9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:43 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)) 16:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:43 INFO - Running setup.py (path:/tmp/pip-UNwSgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:43 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)) 16:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:43 INFO - Running setup.py (path:/tmp/pip-9hOeLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:43 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)) 16:37:43 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)) 16:37:43 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)) 16:37:43 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)) 16:37:43 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)) 16:37:43 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)) 16:37:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:45 INFO - Downloading blessings-1.6.tar.gz 16:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:45 INFO - Installing collected packages: blessings 16:37:45 INFO - Running setup.py install for blessings 16:37:45 INFO - Successfully installed blessings 16:37:45 INFO - Cleaning up... 16:37:45 INFO - Return code: 0 16:37:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:45 INFO - Reading from file tmpfile_stdout 16:37:45 INFO - Current package versions: 16:37:45 INFO - argparse == 1.2.1 16:37:45 INFO - blessings == 1.6 16:37:45 INFO - blobuploader == 1.2.4 16:37:45 INFO - docopt == 0.6.1 16:37:45 INFO - functools32 == 3.2.3-2 16:37:45 INFO - jsonschema == 2.5.1 16:37:45 INFO - manifestparser == 1.1 16:37:45 INFO - mozInstall == 1.12 16:37:45 INFO - mozcrash == 0.17 16:37:45 INFO - mozdebug == 0.1 16:37:45 INFO - mozdevice == 0.48 16:37:45 INFO - mozfile == 1.2 16:37:45 INFO - mozhttpd == 0.7 16:37:45 INFO - mozinfo == 0.9 16:37:45 INFO - mozleak == 0.1 16:37:45 INFO - mozlog == 3.2 16:37:45 INFO - moznetwork == 0.27 16:37:45 INFO - mozprocess == 0.22 16:37:45 INFO - mozprofile == 0.28 16:37:45 INFO - mozrunner == 6.11 16:37:45 INFO - mozscreenshot == 0.1 16:37:45 INFO - mozsystemmonitor == 0.3 16:37:45 INFO - moztest == 0.7 16:37:45 INFO - mozversion == 1.4 16:37:45 INFO - psutil == 3.1.1 16:37:45 INFO - requests == 1.2.3 16:37:45 INFO - wsgiref == 0.1.2 16:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:45 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:45 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 16:37:45 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 16:37:45 INFO - Using env: {'DISPLAY': ':0', 16:37:45 INFO - 'HOME': '/home/cltbld', 16:37:45 INFO - 'LANG': 'en_US.UTF-8', 16:37:45 INFO - 'LANGUAGE': 'en_US:en', 16:37:45 INFO - 'LOGNAME': 'cltbld', 16:37:45 INFO - 'MAIL': '/var/mail/cltbld', 16:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:45 INFO - 'MOZ_NO_REMOTE': '1', 16:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:45 INFO - 'NO_EM_RESTART': '1', 16:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:45 INFO - 'PWD': '/builds/slave/test', 16:37:45 INFO - 'SHELL': '/bin/bash', 16:37:45 INFO - 'SHLVL': '1', 16:37:45 INFO - 'TERM': 'linux', 16:37:45 INFO - 'TMOUT': '86400', 16:37:45 INFO - 'USER': 'cltbld', 16:37:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:45 INFO - '_': '/tools/buildbot/bin/python'} 16:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 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)) 16:37:45 INFO - Cleaning up... 16:37:45 INFO - Return code: 0 16:37:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:37: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')]} 16:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37: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')]} 16:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:45 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 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:45 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 16:37:45 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 16:37:45 INFO - Using env: {'DISPLAY': ':0', 16:37:45 INFO - 'HOME': '/home/cltbld', 16:37:45 INFO - 'LANG': 'en_US.UTF-8', 16:37:45 INFO - 'LANGUAGE': 'en_US:en', 16:37:45 INFO - 'LOGNAME': 'cltbld', 16:37:45 INFO - 'MAIL': '/var/mail/cltbld', 16:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:45 INFO - 'MOZ_NO_REMOTE': '1', 16:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:45 INFO - 'NO_EM_RESTART': '1', 16:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:45 INFO - 'PWD': '/builds/slave/test', 16:37:45 INFO - 'SHELL': '/bin/bash', 16:37:45 INFO - 'SHLVL': '1', 16:37:45 INFO - 'TERM': 'linux', 16:37:45 INFO - 'TMOUT': '86400', 16:37:45 INFO - 'USER': 'cltbld', 16:37:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:45 INFO - '_': '/tools/buildbot/bin/python'} 16:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:37:46 INFO - Cleaning up... 16:37:46 INFO - Return code: 0 16:37:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c3fe1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', '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 16:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:37:46 INFO - Using env: {'DISPLAY': ':0', 16:37:46 INFO - 'HOME': '/home/cltbld', 16:37:46 INFO - 'LANG': 'en_US.UTF-8', 16:37:46 INFO - 'LANGUAGE': 'en_US:en', 16:37:46 INFO - 'LOGNAME': 'cltbld', 16:37:46 INFO - 'MAIL': '/var/mail/cltbld', 16:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:46 INFO - 'MOZ_NO_REMOTE': '1', 16:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:46 INFO - 'NO_EM_RESTART': '1', 16:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:46 INFO - 'PWD': '/builds/slave/test', 16:37:46 INFO - 'SHELL': '/bin/bash', 16:37:46 INFO - 'SHLVL': '1', 16:37:46 INFO - 'TERM': 'linux', 16:37:46 INFO - 'TMOUT': '86400', 16:37:46 INFO - 'USER': 'cltbld', 16:37:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:46 INFO - '_': '/tools/buildbot/bin/python'} 16:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:46 INFO - Downloading/unpacking flake8 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:37:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:37:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:37:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:48 INFO - no previously-included directories found matching 'docs/_build' 16:37:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:37:49 INFO - Running setup.py install for pep8 16:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:37:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:37:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:37:49 INFO - no previously-included directories found matching 'docs/_build' 16:37:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:37:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:37:49 INFO - Cleaning up... 16:37:49 INFO - Return code: 0 16:37:49 INFO - Running post-action listener: _resource_record_post_action 16:37:49 INFO - Running post-action listener: _start_resource_monitoring 16:37:49 INFO - Starting resource monitoring. 16:37:49 INFO - ##### 16:37:49 INFO - ##### Finished create-virtualenv step (success) 16:37:49 INFO - ##### 16:37:49 INFO - ##### 16:37:49 INFO - ##### Running install step. 16:37:49 INFO - ##### 16:37:49 INFO - Running pre-action listener: _resource_record_pre_action 16:37:49 INFO - Running main action method: install 16:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:49 INFO - Reading from file tmpfile_stdout 16:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:49 INFO - Reading from file tmpfile_stdout 16:37:49 INFO - Output received: 16:37:49 INFO - Usage: mozinstall [options] installer 16:37:49 INFO - Options: 16:37:49 INFO - -h, --help show this help message and exit 16:37:49 INFO - -d DEST, --destination=DEST 16:37:49 INFO - Directory to install application into. [default: 16:37:49 INFO - "/builds/slave/test"] 16:37:49 INFO - --app=APP Application being installed. [default: firefox] 16:37:49 INFO - mkdir: /builds/slave/test/build/application 16:37:49 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'] 16:37:49 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 16:38:05 INFO - Reading from file tmpfile_stdout 16:38:05 INFO - Output received: 16:38:05 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:05 INFO - Running post-action listener: _resource_record_post_action 16:38:05 INFO - ##### 16:38:05 INFO - ##### Finished install step (success) 16:38:05 INFO - ##### 16:38:05 INFO - ##### 16:38:05 INFO - ##### Running run-tests step. 16:38:05 INFO - ##### 16:38:05 INFO - Running pre-action listener: _resource_record_pre_action 16:38:05 INFO - Running main action method: run_tests 16:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:05 INFO - Python 2.7.3 16:38:05 INFO - Return code: 0 16:38:05 INFO - grabbing minidump binary from tooltool 16:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b1c0>, '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 0x218c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:38:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:38:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:05 INFO - Return code: 0 16:38:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:38:06 INFO - Return code: 0 16:38:06 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:38:06 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:38:06 INFO - Using env: {'DISPLAY': ':0', 16:38:06 INFO - 'HOME': '/home/cltbld', 16:38:06 INFO - 'LANG': 'en_US.UTF-8', 16:38:06 INFO - 'LANGUAGE': 'en_US:en', 16:38:06 INFO - 'LOGNAME': 'cltbld', 16:38:06 INFO - 'MAIL': '/var/mail/cltbld', 16:38:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:06 INFO - 'MOZ_NO_REMOTE': '1', 16:38:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:06 INFO - 'NO_EM_RESTART': '1', 16:38:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:06 INFO - 'PWD': '/builds/slave/test', 16:38:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:06 INFO - 'SHELL': '/bin/bash', 16:38:06 INFO - 'SHLVL': '1', 16:38:06 INFO - 'TERM': 'linux', 16:38:06 INFO - 'TMOUT': '86400', 16:38:06 INFO - 'USER': 'cltbld', 16:38:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115', 16:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:06 INFO - '_': '/tools/buildbot/bin/python'} 16:38:06 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/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:38:06 INFO - mozversion application_buildid: 20160609160129 16:38:06 INFO - mozversion application_changeset: 880822ee2a0d1e9a847d2f1625964427313fc47a 16:38:06 INFO - mozversion application_display_name: Nightly 16:38:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:06 INFO - mozversion application_name: Firefox 16:38:06 INFO - mozversion application_remotingname: firefox 16:38:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:38:06 INFO - mozversion application_vendor: Mozilla 16:38:06 INFO - mozversion application_version: 50.0a1 16:38:06 INFO - mozversion platform_buildid: 20160609160129 16:38:06 INFO - mozversion platform_changeset: 880822ee2a0d1e9a847d2f1625964427313fc47a 16:38:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:38:06 INFO - mozversion platform_version: 50.0a1 16:38:06 INFO - using testdate: 1465515486 16:38:06 INFO - actual date: 1465515486 16:38:06 INFO - starting webserver on 'localhost:59247' 16:38:06 INFO - SUITE-START | Running 2 tests 16:38:06 INFO - TEST-START | dromaeo_css 16:38:06 INFO - operating with platform_type : linux_ 16:38:06 INFO - Initialising browser for dromaeo_css test... 16:38:06 INFO - TEST-INFO | started process 28609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFu7LHL/profile http://localhost:59247/getInfo.html) 16:38:11 INFO - PROCESS | 28609 | __metrics Screen width/height:1600/1200 16:38:11 INFO - PROCESS | 28609 | colorDepth:24 16:38:11 INFO - PROCESS | 28609 | Browser inner width/height: 1024/697 16:38:11 INFO - PROCESS | 28609 | __metrics 16:38:12 ERROR - PROCESS | 28609 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:38:13 INFO - TEST-INFO | 28609: exit 0 16:38:13 INFO - Browser initialized. 16:38:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:13 INFO - TEST-INFO | started process 28727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFu7LHL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:25 INFO - PROCESS | 28727 | RSS: Main: 185864192 16:38:25 INFO - PROCESS | 28727 | 16:39:15 INFO - PROCESS | 28727 | 1465515555240 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] 16:41:26 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59247/tests/dromaeo/cssquery-ext.html) 16:41:27 INFO - PROCESS | 28727 | RSS: Main: 188837888 16:41:27 INFO - PROCESS | 28727 | 16:44:29 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-ext.html (next: http://localhost:59247/tests/dromaeo/cssquery-jquery.html) 16:44:30 INFO - PROCESS | 28727 | RSS: Main: 187719680 16:44:30 INFO - PROCESS | 28727 | 16:47:32 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59247/tests/dromaeo/cssquery-mootools.html) 16:47:33 INFO - PROCESS | 28727 | RSS: Main: 189349888 16:47:33 INFO - PROCESS | 28727 | 16:50:34 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59247/tests/dromaeo/cssquery-prototype.html) 16:50:35 INFO - PROCESS | 28727 | RSS: Main: 186781696 16:50:35 INFO - PROCESS | 28727 | 16:53:38 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59247/tests/dromaeo/cssquery-yui.html) 16:53:38 INFO - PROCESS | 28727 | RSS: Main: 188481536 16:53:38 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | Cycle 1(1): loaded http://localhost:59247/tests/dromaeo/cssquery-yui.html (next: http://localhost:59247/tests/dromaeo/cssquery-dojo.html) 16:56:41 INFO - PROCESS | 28727 | RSS: Main: 190074880 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | __start_tp_report 16:56:41 INFO - PROCESS | 28727 | _x_x_mozilla_page_load 16:56:41 INFO - PROCESS | 28727 | _x_x_mozilla_page_load_details 16:56:41 INFO - PROCESS | 28727 | |i|pagename|runs| 16:56:41 INFO - PROCESS | 28727 | |0;dojo.html;2582.9483410331786;2658.2822637887766;2690.166048524957;2697.689765676948;2705.621213030176;4654.394928659274;4658.673892827504;4683.484816670168;4763.404574428197;4783.689060211083;4545.9772701136535;4739.549742774431;4779.187538118519;4783.641226907978;4839.540243676845;4288.957110428887;4313.547077556858;4330.97834510827;4412.426384570017;4458.554144585548;4067.8983025424454;4336.761478118702;4400.581944715247;4429;4433.379326894237;4251;4303.483581970184;4315.201687687788;4330.02574420756;4333.263345231318;4327.437433133704;4333.306670932667;4358.978205108954;4367.323064924942;4389.561043895616;4308.569143085698;4328.458942632171;4333.804978775963;4368.104538569585;4402.097569998143;4504.301833215857;4622.075584883037;4670.556297151765;4679.415073115861;4697.765111744399;4972.254161875748;4991.550760431579;5002.874928126789;5020.673656212371;5078.720670363128;4881.975590122062;5015.122353588144;5030.698158110488;5034.471380505068;5094.7197904115255;4667.066586682643;4709.246520556729;4717.716936983792;4724.551167639069;4730;5106.795728170831;5132.769025393866;5136.0241554104605;5153.433122356538;5179.948200518022;4721.102990431807;4865.6107511399005;4956.504349565014;4965.602751779849;5012.24816277554;4846.442659094249;4965.1807451770055;4990.775415106329;5015.774290156952;5054.064997975386;4918.508149185053;4920.360353154067;4973;4980.676256043345;4983.975080124576;4819.95180048202;4890.633202509826;4941.530554597308;4959.70241785494;4999.3000979862845;4134.131832315187;4150.771707556113;4159.188958153191;4208.410822484854;4208.873733787991;3653.725970552219;3662.7069834413182;3695.667389934919;3710.18375957289;3725.590185079639;4367.45406824147;4405.867823965286;4406.537313582027;4423.778811059434;4431.778411079433;5013.749312534432;5017.774200161001;5025.447200807908;5036.345275114285;5089.796408143707;4351.956480435155;4418.381426600278;4418.8453404130705;4421.734695918255;4461.330800379969;4279.893002674958;4491.8652440426185;4506.391637128946;4509.143262780061;4525.547445255448;4895.951040489621;4898.559129678203;4946.233333833262;4954.777035033432;4994.850154495371;4936.9259461107395;5102.387713474258;5119.436861945109;5120.359955005624;5172.689638621695;4853.927191092066;4862.975685121552;4877.195262781602;4880.487548807466;4890.779914903766;4930.260460930889;4952.628552858478;4968.4452662941785;4969.751512424436;5004.47453017428;4846.903061938812;4955.72743499111;5020.949790502048;5029.170186919264;5079.466656001066;4648.651351148745;4837.951620483891;4873.756312184448;4925.064237794808;4927.531884470969;4966.081274964144;4972.825951091694;4975;4975.029869175621;4977.751112444435;4596.057808149255;4798.1843086676045;4902;4911.435184953776;4952.678075925053;4928.383952005999;4960.627952903475;4960.975195124001;4977.228529577921;5027.32131162303;4848.8302909398;4850.587700045536;4854.150523658275;4883.316335713074;4915.164422048332 16:56:41 INFO - PROCESS | 28727 | |1;ext.html;537.6761254455911;573.5612256623682;580.7764010855819;586.8738221282423;603.6106711171298;35412.2917541649;39378.606213937856;39434.21131577374;39761.4035789463;39799.80100099503;39253.21493570127;39692;39698.40452393209;39724.80137599308;39754.20491590167;7459.850802983937;7631.313181813635;7661.463697541174;7690.6154692265445;7698.769036928873;7656.617169141548;7719.614019299041;7720.961395193044;7724.536527808349;7741.729039483619;7677.769666909974;7729.381649468057;7752.418568607349;7756.922430775677;7791.766247012599;7701.1528731839735;7714.151443341256;7716.6527506262355;7721.575313357763;7741.148473667892;7550.546967181932;7578.317951384347;7633.0458692663415;7654.617269136576;7667.3099421052375;36589.451158232645;36973.44539831905;36982;36989.63010369916;37045.44431833525;2204.6252137136726;2674.4784766970447;2716.9728302716917;2739.1782465260344;2768.224897028835;27921.86039069812;28089;28196.71803281982;28432.431351372856;29198.562021569694;3216.903492895217;3220.3559288142465;3224.91937701557;3235.336755965045;3263.216827961296;212992;214220;214548;216092;216628;32131.839340803614;32156.678433215835;32461;32472;32472.83763581167;31920.201994949846;33814;33861.83069084688;33896.49155262673;33940.49089263663;13719.1082579634;13834.861651383559;13918;13973.441062357391;14018.789718154032;11419.714507137389;11494.827577586342;11630.302181868945;11632;11679.824802627967;7711;7798.1811909749795;7807.141214466405;7862.8427431451055;7907.051153861458;3057.6636569977286;3089.073278016586;3094.75241980641;3118.7349075328398;3132.1230055584474;799.4643588795522;830.8326800844823;833.021200089892;865.3077537969599;906.8821053263033;26416.339591509983;26760.866195668896;26948.59577106345;27141.79450953786;27210.727892721214;890.8396488631979;953.2374100719396;957.3346524165777;971.6113554578084;1026.1636766035658;14313.85686143146;14336.784948225784;14336.93901265241;14370.425182992563;14380.85619143816;399314;404459;405471;405617;406969;47495;48738.75630621895;48764;48777.75611121922;49057.264141037915;1142.6000899685043;1168.3574034281112;1172.1853311948284;1194.814803705427;1229.9508019679113;26023.349416263987;26757.331066723487;26817.597736033586;26826.463470730865;26960.191194264204;41683.166336673705;42080.36879446872;42259.7887010563;42332.153356933304;42381;331557.0266445957;332538;332763;333899;334948;24523.75476245286;25180.622290665287;25190.24429267125;25219.495610087328;25953.6106958392;41340;41413;41497.1700565993;41854.74435766932;42470;35336.46995295021;36000.639993599725;36035;36255.81872090622;36668.81665591655;35161.29677406489;35462.113447164025;35698;35956.46065309075;36115;32447.513287300237;35407.46888796722;35637.28725425529;36504.81747591245;36869;29719.70280297256;32406.351872961935;32486.187845304055;32561.34877302488;32631.694732210446;25304.493910121328;25370.619440708037;25400.237992860242;25435.6184657234;25623.871880640476 16:56:41 INFO - PROCESS | 28727 | |2;jquery.html;351.7133536168023;353.8319298333292;354.67901549098065;355.564433568878;369.14542833340795;15777.921110394447;16630;17415.129243537835;17427.1286435678;17449.38927137552;14114.64713382166;16488.587785305343;17005.23476443563;17247.396341128064;17315.653686926253;4902.5342592453835;5073.518015788494;5109.923351149736;5123.2315152727015;5141.768620412072;3072.4623190941497;4833.516648335173;5601.495865372116;5921.378255283198;5938.376470470603;5966.67183304918;5979.252593425822;5993.910091348612;6027.216461859974;6035.275766907977;5861.443162899518;5967.8209653710455;6011.549133814938;6032.426919442646;6050.515958723292;5124.15451450514;5125.359330083739;5158.38099428071;5230;5238.68567885928;20108.39674809758;20494.692579611317;20554.38336849897;20601.278955236645;20617.072231749607;2002.5594369238745;2108.599366120432;2175.010370281518;2203.250894695811;2316.096722278313;13319.533816316383;13415.060945733803;13448.663783405493;13473.595792126252;13745.518906838313;1503.2784263553447;1553.4873491747696;1573.39424321637;1576.7634854771875;1589.3324803582523;63746.681266593834;64238;65865;66373.66813165952;66796.66601667009;9100.31747618918;9257.861132083024;9319.068093190626;9366.67216647414;9450.669226577174;12352.567660131852;12377.504899804087;12402.75194496105;12512.68718282032;12549.749005019848;7243.239459856744;7338.082739657543;7346.6326683666675;7449.515781474187;7458.3758069995865;7210.747623833246;7226.205117437078;7232.168300645388;7247.891281630779;7348.338649521462;5844.26946631671;5949;6070.2412198475195;6079.75680972765;6096.72564734588;1529.4035326222781;1585.3103899803623;1656.3126302584533;1665.9916700416663;1723.5001849463515;792.3027735592642;819.1153554161491;899.3922890776006;923.630547780893;935.4901578639658;16195.352185912667;16913.32346706118;17141.82858171427;17211.827881721274;17308.82691173072;871.333429926107;874.1127755328347;881.1628952495155;930.9022552632011;949.3449519831295;9716.805663886682;9992.200623950066;10093.24300677452;10148.238882083726;10201.693949181536;389912;391675;394719;395490;406259;60772;69097;71447;72497.6375118121;72723;911.3893691226893;918.3892711347013;924.0990034716098;933.1648174883442;949.093615597103;15148.318325675591;15254.771178432555;15254.771178432555;15302.158381289137;15328.540143795704;24613.384665382793;33098.5035224467;33183.83408082944;33494;34279.657203428644;41385.37921931234;42533.78733106315;43960.780196098814;44653.55346446494;44878;7395.630218489162;7433.628318583941;7487.101547814297;7566.659500322388;7753;11351.716207094889;11823.231489953125;11827.290362578273;11839.28964262147;11943.283402995849;9844.655437059668;9886.604535818487;10132.13876820449;10272.22958278147;10454.58181672755;9954.352967057119;10089.133510300619;10248.897511025092;10271.435071070864;10581.576736930436;10243.48782560884;10292;10329.483525823529;10444.63443779464;10457.163426925676;7469.215732348025;7530.924690753022;7571.621418929141;7589.354904833151;7630.7329243476215;10003.749906252402;10190;10257.692269231935;10375.584976600852;10508.42203678805 16:56:41 INFO - PROCESS | 28727 | |3;mootools.html;1364.7748121559944;1393.066645347617;1457.7886206500057;1607.0919930239406;1614.878884083694;6485.767704136211;7210.387117095047;7635.121960974476;7672;7750.4187185961;7698.730544430946;7790.104138024115;7842.176571460001;7881.133075361706;7917.129115797257;2160.2331172433755;2202.1081462007915;2207.8233741300655;2209.2267706302746;2209.5139069404704;2134.5624147049816;2137.2519618133606;2141.379000089972;2142.817860481861;2154.052217024512;2144.5710857828417;2150.8064274215317;2165.1880544795704;2179.1283486605407;2194.868307901523;1991.9302824401077;1999.6700544410155;2007.7691065527433;2010.3466373428694;2013.7885522020124;2090.696848956908;2092.529180934293;2093.612681653899;2105.4104850641843;2107.6838474228834;7828.5694286814205;7948;7948.443608947376;7972.322352599978;7976.561289129096;4468.8882777930485;4597.287420449802;4607.14767767964;4608.216603177468;4611.193041217807;2752.270648278208;2830.377316990259;2840.61651677023;2864.240976141324;2912.9708702912912;875.6974198554017;910.2126660438673;916.6837441082815;924.5377311344328;934.1592566689966;10539;10595.470226488645;10598.788024239471;10618.787624247472;10622.15022798182;3967.0875698589484;3985.621365970228;4038.192361527706;4058.1477889643506;4183.811728472226;8960.551972401354;9004.729858104267;9009.324300677476;9025.458472491671;9046.411983221069;4352.368906508538;4398.472183337956;4418.094290670405;4633.258678611406;4671.416072990876;3400.812955287483;4056.0468289951837;4064.0246340877975;4150.398192262105;4242.681798865097;3417.1115509967585;3477.6348483409383;3519.1905861651962;3522.137076416243;3586.246888153517;1153.798085335063;1166.8891455311732;1176.5764324843049;1184.2539200303754;1184.6860581945791;688.2394953576227;745.37760969591;754.35125791819;816.2775943290231;816.9877451838228;4987.501249874984;5210.505002024802;5213.165893457029;5230.555402790729;5246.973765131226;393.3117045170951;395.170142700327;399.4328054163095;401.2536681771902;401.6405317241053;3336.4661654135707;3475.826208689606;3510.4558793387064;3512.473129030615;3535.911602209965;9308.906910930804;9738.610455581838;9755.463449510204;9759.414435133915;9761;9491.857622135674;9550;9575.952120239353;9619.422834629944;9629.614815407305;6936.7572134975035;7326.267373262631;7334.119905611254;7379.741709040158;7422.29488198631;5214.843554693365;5248.711320877388;5273.630845840754;5352.5985551084605;5372.1941708744;8656.350773692124;8665.783355416164;8977.820443591223;9037.954810225907;9106.408083474553;9020.548972551214;9100.135487128713;9155.816883662423;9208.217301529445;9231.261499079923;5713.400092990342;6208.441240288395;6432.581882177644;6628.204615446178;6803.659817009031;7437.181909990005;7454.329110380092;7462.403007759474;7465.850682986201;7493.175750667531;6608.240052394036;6762.6280554568;6778.118844550177;6794.42247408956;6943.930560694328;6224;6258.9374106260175;6350.872982540231;6378.872422551616;6394.552381333262;5931.08068249422;5932.13983972313;5938.198343223609;5951.16683664296;5992.280926288873;4269.935950960676;4410.911781764283;4412.889677758082;4428.180786554498;4456.064226512339;4397.538258482813;4437.844675436344;4501.6848820582245;4505.819767209275;4516.074204787945 16:56:41 INFO - PROCESS | 28727 | |4;prototype.html;283.76138156944927;289.9608552845366;294.4244002974185;295.3163426667265;296.32290216854494;4782.33047373368;4851.514848515147;4877.634177436693;4941.752912354382;4962.40451145863;4879.3656824612835;4879.609631229502;4887.657863949525;4899.069176856395;4912.631552633549;3764.832901800437;3790.5072340595684;3819.255245227189;3820.4269359596005;3830.157365379612;3706.759060661062;3824.9808750956345;3836.865709700161;3847.442120892469;3860.9420858687004;3787.299349620329;3791.279656865187;3794.3739283018267;3798.8290526926216;3801.486799282089;3768.6419790119894;3769.4157405602177;3806.4480650305827;3822.388417853158;3829.329867273216;3349.363620912019;3359.395308844407;3362.7982321060813;3376.6285708572036;3378.5303393024114;4535.750533720644;4832.782524786393;4875.366202393701;4882.877928051792;4884.853454396374;4244.511881133678;4253.404523366731;4271.611726189001;4277.529471758104;4282.678799090081;5120.129577971754;5142.020322175952;5143.922841157386;5168.534831865112;5173.0688476074665;3533.2580158166816;3608.963910360915;3610.530631017977;3615.403458429356;3618.5115009473648;5314.787408503656;5318.946810531884;5321.148616221386;5321.855801002765;5328.653637513588;3626.5285512883156;3641.308151451216;3655.6527129922615;3661.6338366163172;3666.2300916807235;3694.7783133012103;3706.5181526401393;3708.1841994761107;3714.647108524686;3735.4957080793747;4033.8100260423244;4212.136512015029;4261.701680882308;4270.444842170498;4298.78506074695;5081.74591270435;5107.803644432855;5114;5114.514121158484;5121.231815227746;1207.4506099724604;1242.1491278474275;1273.2996851731511;1276.495784165268;1276.961691149267;796.5658715999793;807.3097501636134;812.3054788156041;813.3940214540087;818.2717381530442;4121.5466298707115;4121.876343709693;4132.648724858421;4139.379093136054;4143.18263580768;4703.247480403119;4716.1510928033285;4733.219018861918;4733.715977041388;4739.03330118004;4115.506139263308;4157.147784704189;4185.9581404185565;4201.831926722897;4219.2194444027955;2295.6900818389636;2536.9978858350846;2545.8090643201836;2558.684390626486;2592.3519120219944;4521.344405061248;4522.909541809146;4541.296099104644;4562.977185114053;4592.67851250416;4767.95232047682;4775.832845850378;4789.473157952622;4830.468648448667;4844.89247177479;4431.246688062973;4623.31847528426;4625.606823420047;4648.651351148677;4659.161350956792;4691.648126390603;4742.288656701385;4782.0914026334885;4787.473377928355;4796.409938633099;4674.218839790319;4690.15577196108;4691.648126390466;4711.175544279668;4719.221328480762;4620.5148459411275;4628.213203755437;4824.807007719652;5239.214117882349;5245;3661.7436779425184;3691.9630803692694;3692.1323488980606;3700.463432802175;3705.4256590228556;5103.821366252163;5358.812441564526;5410.810621628224;5417.187421886749;5424.484673955968;5024.4975502450925;5166.664166829144;5167.302414174038;5180.585553155664;5183.663061900965;5172.293143262789;5188.818391356284;5190.480951904779;5199.324087868704;5215.869603259949;4927.8275260367145;5080.212567052113;5082.872928176826;5137.563307118937;5146.47822566932;5166.3800343958965;5191.610629202901;5194.870128246824;5225.451327610698;5236.293100431393;5111.79552817898;5115.744212789271;5123.666961647481;5124.923126153185;5146.176611742103 16:56:41 INFO - PROCESS | 28727 | |5;yui.html;497.52237851662403;500.8847964968055;506.7137067556831;537.4920699938557;537.6397813464978;10494.265401421893;11058;11138.164637652178;11142.27575207611;11166.106711463073;11294.040006599429;11350.489227984739;11379;12318.876811231885;12809.743805123891;609.4301827791007;752.578556008637;786.1941509952287;792.2869417524246;794.2295972906301;772.8724760414525;773.6247919758913;773.6943907156669;774.6204359863683;782.8160382310152;802.4864086984335;804.0833449867156;804.9074356449024;805.2028491793142;806.2219957740779;787.5943888897194;794.0114557376104;796.7410591557767;798.3892322373389;804.9718259860906;588.608575297431;589.4047012517345;589.5813972079828;591.204829504316;591.9556033297476;12169.817452738216;12369.93815030919;12389.318587477685;12401.379931003414;12410.193337433127;12202.938985305105;12219.572314968933;12653.936730316382;12691.555795547112;12732.917701995342;8867.911320886773;8892.777680558038;9188.127127922837;9728.319017668766;9996;3249.333886553251;3268.444364458048;3303.8678452861855;3363.0751543325537;3406.097384193191;49419.50580494221;50966;50979.74510127425;61849.690751546404;63286;9528.857067143997;9568.4737339447;9626.90373096274;9672.274579406572;10035.899641003643;16605.58486037859;16901.070441125612;17388.391406300718;17604.471865844047;18511.259549618135;6304.117423560705;6417.935820641827;6531.836704082436;6811.659417029129;6814.693338799766;3395.3379091077004;3581.3732596795458;3593.2274560969518;3610.3140403323287;3687.502187204747;2714.1993112031996;2810.9156725298276;2813.1560531840364;2821.0549465929143;2831.0232969625445;457.3779659662922;460.5630531574792;464.8001359415416;466.44260109169215;469.68061718031385;423.686472010716;425.5786771096592;494.54007772771666;511.9692818430906;524.2372348233312;6772.8984065239065;6779.559328643622;6805.251422343637;6830.487713421513;6832.555883867532;466.16556364108544;495.55152586908906;505.290067455226;541.2206422751226;544.8855740294504;3320.053784671357;3335.09952312879;3350.5644266245718;3362.0922350965593;3409.3863104641405;61365.386346135965;89561.55219223863;91563.54218228866;91822;92659;50543;61116;68957.65521172361;76380;80229;69201.96197057048;69475.30524694688;70302.64848675724;70912;71330.99999999897;6389.584676995981;6439.484841212598;6442.323556026738;6455.870882582228;6489.5781774184525;31027.689723103384;35657.64342356543;43377;44141.558584413746;44202.55797441985;55449.44550554443;61466.385336147854;61853.69073154785;61883.690581546805;62383;8691.65279381697;8791.428557143765;8904.643814247358;9001;9019.233365164035;9541.332106752461;9725.708228753148;9849.950750246202;9885.50572471388;9894.703158905244;8729.476231426135;8773.166549177819;8833.646654133763;8989.01120876716;9069.22911552499;9282.814343712953;9660.75848103803;9800.264980126662;10088.747781305527;10098;9402.576884040098;9517.381370210915;9828.361156524803;9901.50492475359;10264.794704105727;8121.1472795358;8143.307818835466;8552.700655477029;8646.308295336232;8859.645614175619;7249.963750181215;7264.854702905806;7288.409059219585;7531.322181003736;7556.4710470266555 16:56:41 INFO - PROCESS | 28727 | __end_tp_report 16:56:41 INFO - PROCESS | 28727 | __start_cc_report 16:56:41 INFO - PROCESS | 28727 | _x_x_mozilla_cycle_collect,381 16:56:41 INFO - PROCESS | 28727 | __end_cc_report 16:56:41 INFO - PROCESS | 28727 | __startTimestamp1465516601728__endTimestamp 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | ------- Summary: start ------- 16:56:41 INFO - PROCESS | 28727 | Number of tests: 6 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#0] dojo.html Cycles:165 Average:4654.84 Median:4846.90 stddev:484.91 (10.0%) stddev-sans-first:458.35 16:56:41 INFO - PROCESS | 28727 | Values: 2582.9 2658.3 2690.2 2697.7 2705.6 4654.4 4658.7 4683.5 4763.4 4783.7 4546.0 4739.5 4779.2 4783.6 4839.5 4289.0 4313.5 4331.0 4412.4 4458.6 4067.9 4336.8 4400.6 4429.0 4433.4 4251.0 4303.5 4315.2 4330.0 4333.3 4327.4 4333.3 4359.0 4367.3 4389.6 4308.6 4328.5 4333.8 4368.1 4402.1 4504.3 4622.1 4670.6 4679.4 4697.8 4972.3 4991.6 5002.9 5020.7 5078.7 4882.0 5015.1 5030.7 5034.5 5094.7 4667.1 4709.2 4717.7 4724.6 4730.0 5106.8 5132.8 5136.0 5153.4 5179.9 4721.1 4865.6 4956.5 4965.6 5012.2 4846.4 4965.2 4990.8 5015.8 5054.1 4918.5 4920.4 4973.0 4980.7 4984.0 4820.0 4890.6 4941.5 4959.7 4999.3 4134.1 4150.8 4159.2 4208.4 4208.9 3653.7 3662.7 3695.7 3710.2 3725.6 4367.5 4405.9 4406.5 4423.8 4431.8 5013.7 5017.8 5025.4 5036.3 5089.8 4352.0 4418.4 4418.8 4421.7 4461.3 4279.9 4491.9 4506.4 4509.1 4525.5 4896.0 4898.6 4946.2 4954.8 4994.9 4936.9 5102.4 5119.4 5120.4 5172.7 4853.9 4863.0 4877.2 4880.5 4890.8 4930.3 4952.6 4968.4 4969.8 5004.5 4846.9 4955.7 5020.9 5029.2 5079.5 4648.7 4838.0 4873.8 4925.1 4927.5 4966.1 4972.8 4975.0 4975.0 4977.8 4596.1 4798.2 4902.0 4911.4 4952.7 4928.4 4960.6 4961.0 4977.2 5027.3 4848.8 4850.6 4854.2 4883.3 4915.2 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#1] ext.html Cycles:180 Average:45449.23 Median:35437.20 stddev:86537.36 (244.2%) stddev-sans-first:86714.43 16:56:41 INFO - PROCESS | 28727 | Values: 537.7 573.6 580.8 586.9 603.6 35412.3 39378.6 39434.2 39761.4 39799.8 39253.2 39692.0 39698.4 39724.8 39754.2 7459.9 7631.3 7661.5 7690.6 7698.8 7656.6 7719.6 7721.0 7724.5 7741.7 7677.8 7729.4 7752.4 7756.9 7791.8 7701.2 7714.2 7716.7 7721.6 7741.1 7550.5 7578.3 7633.0 7654.6 7667.3 36589.5 36973.4 36982.0 36989.6 37045.4 2204.6 2674.5 2717.0 2739.2 2768.2 27921.9 28089.0 28196.7 28432.4 29198.6 3216.9 3220.4 3224.9 3235.3 3263.2 212992.0 214220.0 214548.0 216092.0 216628.0 32131.8 32156.7 32461.0 32472.0 32472.8 31920.2 33814.0 33861.8 33896.5 33940.5 13719.1 13834.9 13918.0 13973.4 14018.8 11419.7 11494.8 11630.3 11632.0 11679.8 7711.0 7798.2 7807.1 7862.8 7907.1 3057.7 3089.1 3094.8 3118.7 3132.1 799.5 830.8 833.0 865.3 906.9 26416.3 26760.9 26948.6 27141.8 27210.7 890.8 953.2 957.3 971.6 1026.2 14313.9 14336.8 14336.9 14370.4 14380.9 399314.0 404459.0 405471.0 405617.0 406969.0 47495.0 48738.8 48764.0 48777.8 49057.3 1142.6 1168.4 1172.2 1194.8 1230.0 26023.3 26757.3 26817.6 26826.5 26960.2 41683.2 42080.4 42259.8 42332.2 42381.0 331557.0 332538.0 332763.0 333899.0 334948.0 24523.8 25180.6 25190.2 25219.5 25953.6 41340.0 41413.0 41497.2 41854.7 42470.0 35336.5 36000.6 36035.0 36255.8 36668.8 35161.3 35462.1 35698.0 35956.5 36115.0 32447.5 35407.5 35637.3 36504.8 36869.0 29719.7 32406.4 32486.2 32561.3 32631.7 25304.5 25370.6 25400.2 25435.6 25623.9 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#2] jquery.html Cycles:180 Average:23916.76 Median:223822.19 stddev:64937.34 (29.0%) stddev-sans-first:65095.40 16:56:41 INFO - PROCESS | 28727 | Values: 351.7 353.8 354.7 355.6 369.1 15777.9 16630.0 17415.1 17427.1 17449.4 14114.6 16488.6 17005.2 17247.4 17315.7 4902.5 5073.5 5109.9 5123.2 5141.8 3072.5 4833.5 5601.5 5921.4 5938.4 5966.7 5979.3 5993.9 6027.2 6035.3 5861.4 5967.8 6011.5 6032.4 6050.5 5124.2 5125.4 5158.4 5230.0 5238.7 20108.4 20494.7 20554.4 20601.3 20617.1 2002.6 2108.6 2175.0 2203.3 2316.1 13319.5 13415.1 13448.7 13473.6 13745.5 1503.3 1553.5 1573.4 1576.8 1589.3 63746.7 64238.0 65865.0 66373.7 66796.7 9100.3 9257.9 9319.1 9366.7 9450.7 12352.6 12377.5 12402.8 12512.7 12549.7 7243.2 7338.1 7346.6 7449.5 7458.4 7210.7 7226.2 7232.2 7247.9 7348.3 5844.3 5949.0 6070.2 6079.8 6096.7 1529.4 1585.3 1656.3 1666.0 1723.5 792.3 819.1 899.4 923.6 935.5 16195.4 16913.3 17141.8 17211.8 17308.8 871.3 874.1 881.2 930.9 949.3 9716.8 9992.2 10093.2 10148.2 10201.7 389912.0 391675.0 394719.0 395490.0 406259.0 60772.0 69097.0 71447.0 72497.6 72723.0 911.4 918.4 924.1 933.2 949.1 15148.3 15254.8 15254.8 15302.2 15328.5 24613.4 33098.5 33183.8 33494.0 34279.7 41385.4 42533.8 43960.8 44653.6 44878.0 7395.6 7433.6 7487.1 7566.7 7753.0 11351.7 11823.2 11827.3 11839.3 11943.3 9844.7 9886.6 10132.1 10272.2 10454.6 9954.4 10089.1 10248.9 10271.4 10581.6 10243.5 10292.0 10329.5 10444.6 10457.2 7469.2 7530.9 7571.6 7589.4 7630.7 10003.7 10190.0 10257.7 10375.6 10508.4 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#3] mootools.html Cycles:180 Average:5048.25 Median:5099.00 stddev:2897.55 (56.8%) stddev-sans-first:2892.46 16:56:41 INFO - PROCESS | 28727 | Values: 1364.8 1393.1 1457.8 1607.1 1614.9 6485.8 7210.4 7635.1 7672.0 7750.4 7698.7 7790.1 7842.2 7881.1 7917.1 2160.2 2202.1 2207.8 2209.2 2209.5 2134.6 2137.3 2141.4 2142.8 2154.1 2144.6 2150.8 2165.2 2179.1 2194.9 1991.9 1999.7 2007.8 2010.3 2013.8 2090.7 2092.5 2093.6 2105.4 2107.7 7828.6 7948.0 7948.4 7972.3 7976.6 4468.9 4597.3 4607.1 4608.2 4611.2 2752.3 2830.4 2840.6 2864.2 2913.0 875.7 910.2 916.7 924.5 934.2 10539.0 10595.5 10598.8 10618.8 10622.2 3967.1 3985.6 4038.2 4058.1 4183.8 8960.6 9004.7 9009.3 9025.5 9046.4 4352.4 4398.5 4418.1 4633.3 4671.4 3400.8 4056.0 4064.0 4150.4 4242.7 3417.1 3477.6 3519.2 3522.1 3586.2 1153.8 1166.9 1176.6 1184.3 1184.7 688.2 745.4 754.4 816.3 817.0 4987.5 5210.5 5213.2 5230.6 5247.0 393.3 395.2 399.4 401.3 401.6 3336.5 3475.8 3510.5 3512.5 3535.9 9308.9 9738.6 9755.5 9759.4 9761.0 9491.9 9550.0 9576.0 9619.4 9629.6 6936.8 7326.3 7334.1 7379.7 7422.3 5214.8 5248.7 5273.6 5352.6 5372.2 8656.4 8665.8 8977.8 9038.0 9106.4 9020.5 9100.1 9155.8 9208.2 9231.3 5713.4 6208.4 6432.6 6628.2 6803.7 7437.2 7454.3 7462.4 7465.9 7493.2 6608.2 6762.6 6778.1 6794.4 6943.9 6224.0 6258.9 6350.9 6378.9 6394.6 5931.1 5932.1 5938.2 5951.2 5992.3 4269.9 4410.9 4412.9 4428.2 4456.1 4397.5 4437.8 4501.7 4505.8 4516.1 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#4] prototype.html Cycles:180 Average:4143.38 Median:4638.43 stddev:1216.11 (26.2%) stddev-sans-first:1184.51 16:56:41 INFO - PROCESS | 28727 | Values: 283.8 290.0 294.4 295.3 296.3 4782.3 4851.5 4877.6 4941.8 4962.4 4879.4 4879.6 4887.7 4899.1 4912.6 3764.8 3790.5 3819.3 3820.4 3830.2 3706.8 3825.0 3836.9 3847.4 3860.9 3787.3 3791.3 3794.4 3798.8 3801.5 3768.6 3769.4 3806.4 3822.4 3829.3 3349.4 3359.4 3362.8 3376.6 3378.5 4535.8 4832.8 4875.4 4882.9 4884.9 4244.5 4253.4 4271.6 4277.5 4282.7 5120.1 5142.0 5143.9 5168.5 5173.1 3533.3 3609.0 3610.5 3615.4 3618.5 5314.8 5318.9 5321.1 5321.9 5328.7 3626.5 3641.3 3655.7 3661.6 3666.2 3694.8 3706.5 3708.2 3714.6 3735.5 4033.8 4212.1 4261.7 4270.4 4298.8 5081.7 5107.8 5114.0 5114.5 5121.2 1207.5 1242.1 1273.3 1276.5 1277.0 796.6 807.3 812.3 813.4 818.3 4121.5 4121.9 4132.6 4139.4 4143.2 4703.2 4716.2 4733.2 4733.7 4739.0 4115.5 4157.1 4186.0 4201.8 4219.2 2295.7 2537.0 2545.8 2558.7 2592.4 4521.3 4522.9 4541.3 4563.0 4592.7 4768.0 4775.8 4789.5 4830.5 4844.9 4431.2 4623.3 4625.6 4648.7 4659.2 4691.6 4742.3 4782.1 4787.5 4796.4 4674.2 4690.2 4691.6 4711.2 4719.2 4620.5 4628.2 4824.8 5239.2 5245.0 3661.7 3692.0 3692.1 3700.5 3705.4 5103.8 5358.8 5410.8 5417.2 5424.5 5024.5 5166.7 5167.3 5180.6 5183.7 5172.3 5188.8 5190.5 5199.3 5215.9 4927.8 5080.2 5082.9 5137.6 5146.5 5166.4 5191.6 5194.9 5225.5 5236.3 5111.8 5115.7 5123.7 5124.9 5146.2 16:56:41 INFO - PROCESS | 28727 | 16:56:41 INFO - PROCESS | 28727 | [#5] yui.html Cycles:180 Average:15674.31 Median:62133.35 stddev:22653.65 (36.5%) stddev-sans-first:22688.54 16:56:41 INFO - PROCESS | 28727 | Values: 497.5 500.9 506.7 537.5 537.6 10494.3 11058.0 11138.2 11142.3 11166.1 11294.0 11350.5 11379.0 12318.9 12809.7 609.4 752.6 786.2 792.3 794.2 772.9 773.6 773.7 774.6 782.8 802.5 804.1 804.9 805.2 806.2 787.6 794.0 796.7 798.4 805.0 588.6 589.4 589.6 591.2 592.0 12169.8 12369.9 12389.3 12401.4 12410.2 12202.9 12219.6 12653.9 12691.6 12732.9 8867.9 8892.8 9188.1 9728.3 9996.0 3249.3 3268.4 3303.9 3363.1 3406.1 49419.5 50966.0 50979.7 61849.7 63286.0 9528.9 9568.5 9626.9 9672.3 10035.9 16605.6 16901.1 17388.4 17604.5 18511.3 6304.1 6417.9 6531.8 6811.7 6814.7 3395.3 3581.4 3593.2 3610.3 3687.5 2714.2 2810.9 2813.2 2821.1 2831.0 457.4 460.6 464.8 466.4 469.7 423.7 425.6 494.5 512.0 524.2 6772.9 6779.6 6805.3 6830.5 6832.6 466.2 495.6 505.3 541.2 544.9 3320.1 3335.1 3350.6 3362.1 3409.4 61365.4 89561.6 91563.5 91822.0 92659.0 50543.0 61116.0 68957.7 76380.0 80229.0 69202.0 69475.3 70302.6 70912.0 71331.0 6389.6 6439.5 6442.3 6455.9 6489.6 31027.7 35657.6 43377.0 44141.6 44202.6 55449.4 61466.4 61853.7 61883.7 62383.0 8691.7 8791.4 8904.6 9001.0 9019.2 9541.3 9725.7 9850.0 9885.5 9894.7 8729.5 8773.2 8833.6 8989.0 9069.2 9282.8 9660.8 9800.3 10088.7 10098.0 9402.6 9517.4 9828.4 9901.5 10264.8 8121.1 8143.3 8552.7 8646.3 8859.6 7250.0 7264.9 7288.4 7531.3 7556.5 16:56:41 INFO - PROCESS | 28727 | -------- Summary: end -------- 16:56:41 INFO - PROCESS | 28727 | 16:56:42 INFO - TEST-INFO | 28727: exit 0 16:56:42 INFO - TEST-OK | dromaeo_css | took 1115830ms 16:56:42 INFO - TEST-START | kraken 16:56:42 INFO - operating with platform_type : linux_ 16:56:42 INFO - Initialising browser for kraken test... 16:56:42 INFO - TEST-INFO | started process 28967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd0a2mV/profile http://localhost:59247/getInfo.html) 16:56:47 INFO - PROCESS | 28967 | __metrics Screen width/height:1600/1200 16:56:47 INFO - PROCESS | 28967 | colorDepth:24 16:56:47 INFO - PROCESS | 28967 | Browser inner width/height: 1024/697 16:56:47 INFO - PROCESS | 28967 | __metrics 16:56:48 ERROR - PROCESS | 28967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:56:49 INFO - TEST-INFO | 28967: exit 0 16:56:49 INFO - Browser initialized. 16:56:49 INFO - Running cycle 1/1 for kraken test... 16:56:49 INFO - TEST-INFO | started process 29083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd0a2mV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:01 INFO - PROCESS | 29083 | RSS: Main: 185569280 16:57:01 INFO - PROCESS | 29083 | 16:57:03 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59247/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:04 INFO - PROCESS | 29083 | RSS: Main: 189911040 16:57:04 INFO - PROCESS | 29083 | 16:57:07 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59247/tests/kraken/driver.html?testName=audio-dft) 16:57:08 INFO - PROCESS | 29083 | RSS: Main: 189227008 16:57:08 INFO - PROCESS | 29083 | 16:57:11 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59247/tests/kraken/driver.html?testName=audio-fft) 16:57:11 INFO - PROCESS | 29083 | RSS: Main: 185360384 16:57:11 INFO - PROCESS | 29083 | 16:57:13 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59247/tests/kraken/driver.html?testName=audio-oscillator) 16:57:14 INFO - PROCESS | 29083 | RSS: Main: 185528320 16:57:14 INFO - PROCESS | 29083 | 16:57:16 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:17 INFO - PROCESS | 29083 | RSS: Main: 185991168 16:57:17 INFO - PROCESS | 29083 | 16:57:20 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59247/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:21 INFO - PROCESS | 29083 | RSS: Main: 186580992 16:57:21 INFO - PROCESS | 29083 | 16:57:24 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59247/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:25 INFO - PROCESS | 29083 | RSS: Main: 184184832 16:57:25 INFO - PROCESS | 29083 | 16:57:28 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59247/tests/kraken/driver.html?testName=json-parse-financial) 16:57:29 INFO - PROCESS | 29083 | RSS: Main: 185176064 16:57:29 INFO - PROCESS | 29083 | 16:57:30 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:31 INFO - PROCESS | 29083 | RSS: Main: 185630720 16:57:31 INFO - PROCESS | 29083 | 16:57:33 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:33 INFO - PROCESS | 29083 | RSS: Main: 186126336 16:57:33 INFO - PROCESS | 29083 | 16:57:36 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:36 INFO - PROCESS | 29083 | RSS: Main: 186720256 16:57:36 INFO - PROCESS | 29083 | 16:57:39 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:40 INFO - PROCESS | 29083 | RSS: Main: 186810368 16:57:40 INFO - PROCESS | 29083 | 16:57:43 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:43 INFO - PROCESS | 29083 | RSS: Main: 186527744 16:57:43 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | Cycle 1(1): loaded http://localhost:59247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59247/tests/kraken/driver.html?testName=ai-astar) 16:57:45 INFO - PROCESS | 29083 | RSS: Main: 187244544 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | __start_tp_report 16:57:45 INFO - PROCESS | 29083 | _x_x_mozilla_page_load 16:57:45 INFO - PROCESS | 29083 | _x_x_mozilla_page_load_details 16:57:45 INFO - PROCESS | 29083 | |i|pagename|runs| 16:57:45 INFO - PROCESS | 29083 | |0;ai-astar;114;110;114;114;114;114;113;113;114;115 16:57:45 INFO - PROCESS | 29083 | |1;audio-beat-detection;162;141;161;191;130;167;163;133;187;134 16:57:45 INFO - PROCESS | 29083 | |2;audio-dft;163;166;184;162;167;163;163;162;163;162 16:57:45 INFO - PROCESS | 29083 | |3;audio-fft;75;76;77;173;77;76;75;77;160;77 16:57:45 INFO - PROCESS | 29083 | |4;audio-oscillator;87;87;134;85;87;86;132;86;87;138 16:57:45 INFO - PROCESS | 29083 | |5;imaging-gaussian-blur;118;118;118;118;119;119;118;118;119;118 16:57:45 INFO - PROCESS | 29083 | |6;imaging-darkroom;147;149;148;147;148;148;148;148;149;147 16:57:45 INFO - PROCESS | 29083 | |7;imaging-desaturate;95;96;96;96;96;96;95;95;95;95 16:57:45 INFO - PROCESS | 29083 | |8;json-parse-financial;63;64;64;64;65;64;64;68;66;64 16:57:45 INFO - PROCESS | 29083 | |9;json-stringify-tinderbox;64;65;65;65;66;65;65;65;65;65 16:57:45 INFO - PROCESS | 29083 | |10;stanford-crypto-aes;87;84;83;86;86;83;85;87;118;85 16:57:45 INFO - PROCESS | 29083 | |11;stanford-crypto-ccm;141;138;157;139;134;142;134;132;153;136 16:57:45 INFO - PROCESS | 29083 | |12;stanford-crypto-pbkdf2;171;176;174;169;172;168;168;169;168;167 16:57:45 INFO - PROCESS | 29083 | |13;stanford-crypto-sha256-iterative;70;68;68;66;68;71;71;68;67;67 16:57:45 INFO - PROCESS | 29083 | __end_tp_report 16:57:45 INFO - PROCESS | 29083 | __start_cc_report 16:57:45 INFO - PROCESS | 29083 | _x_x_mozilla_cycle_collect,978 16:57:45 INFO - PROCESS | 29083 | __end_cc_report 16:57:45 INFO - PROCESS | 29083 | __startTimestamp1465516665845__endTimestamp 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | ------- Summary: start ------- 16:57:45 INFO - PROCESS | 29083 | Number of tests: 14 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 16:57:45 INFO - PROCESS | 29083 | Values: 114.0 110.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 115.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:162.50 stddev:21.92 (13.5%) stddev-sans-first:23.17 16:57:45 INFO - PROCESS | 29083 | Values: 162.0 141.0 161.0 191.0 130.0 167.0 163.0 133.0 187.0 134.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#2] audio-dft Cycles:10 Average:165.50 Median:163.00 stddev:6.72 (4.1%) stddev-sans-first:7.07 16:57:45 INFO - PROCESS | 29083 | Values: 163.0 166.0 184.0 162.0 167.0 163.0 163.0 162.0 163.0 162.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.50 stddev:38.18 (49.9%) stddev-sans-first:39.86 16:57:45 INFO - PROCESS | 29083 | Values: 75.0 76.0 77.0 173.0 77.0 76.0 75.0 77.0 160.0 77.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:86.50 stddev:23.35 (27.0%) stddev-sans-first:24.22 16:57:45 INFO - PROCESS | 29083 | Values: 87.0 87.0 134.0 85.0 87.0 86.0 132.0 86.0 87.0 138.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:57:45 INFO - PROCESS | 29083 | Values: 118.0 118.0 118.0 118.0 119.0 119.0 118.0 118.0 119.0 118.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:57:45 INFO - PROCESS | 29083 | Values: 147.0 149.0 148.0 147.0 148.0 148.0 148.0 148.0 149.0 147.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:57:45 INFO - PROCESS | 29083 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.39 16:57:45 INFO - PROCESS | 29083 | Values: 63.0 64.0 64.0 64.0 65.0 64.0 64.0 68.0 66.0 64.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 16:57:45 INFO - PROCESS | 29083 | Values: 64.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.50 stddev:10.50 (12.3%) stddev-sans-first:11.13 16:57:45 INFO - PROCESS | 29083 | Values: 87.0 84.0 83.0 86.0 86.0 83.0 85.0 87.0 118.0 85.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:140.00 stddev:8.28 (5.9%) stddev-sans-first:8.78 16:57:45 INFO - PROCESS | 29083 | Values: 141.0 138.0 157.0 139.0 134.0 142.0 134.0 132.0 153.0 136.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.00 stddev:2.97 (1.7%) stddev-sans-first:3.14 16:57:45 INFO - PROCESS | 29083 | Values: 171.0 176.0 174.0 169.0 172.0 168.0 168.0 169.0 168.0 167.0 16:57:45 INFO - PROCESS | 29083 | 16:57:45 INFO - PROCESS | 29083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.71 (2.5%) stddev-sans-first:1.72 16:57:45 INFO - PROCESS | 29083 | Values: 70.0 68.0 68.0 66.0 68.0 71.0 71.0 68.0 67.0 67.0 16:57:45 INFO - PROCESS | 29083 | -------- Summary: end -------- 16:57:45 INFO - PROCESS | 29083 | 16:57:46 INFO - TEST-INFO | 29083: exit 0 16:57:46 INFO - TEST-OK | kraken | took 64442ms 16:57:46 INFO - SUITE-END | took 1180s 16:57:47 INFO - Completed test suite (00:19:40) 16:57:47 INFO - javascript benchmark 16:57:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6122.573202848221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.9483410331786, 2658.2822637887766, 2690.166048524957, 2697.689765676948, 2705.621213030176, 4654.394928659274, 4658.673892827504, 4683.484816670168, 4763.404574428197, 4783.689060211083, 4545.9772701136535, 4739.549742774431, 4779.187538118519, 4783.641226907978, 4839.540243676845, 4288.957110428887, 4313.547077556858, 4330.97834510827, 4412.426384570017, 4458.554144585548, 4067.8983025424454, 4336.761478118702, 4400.581944715247, 4429.0, 4433.379326894237, 4251.0, 4303.483581970184, 4315.201687687788, 4330.02574420756, 4333.263345231318, 4327.437433133704, 4333.306670932667, 4358.978205108954, 4367.323064924942, 4389.561043895616, 4308.569143085698, 4328.458942632171, 4333.804978775963, 4368.104538569585, 4402.097569998143, 4504.301833215857, 4622.075584883037, 4670.556297151765, 4679.415073115861, 4697.765111744399, 4972.254161875748, 4991.550760431579, 5002.874928126789, 5020.673656212371, 5078.720670363128, 4881.975590122062, 5015.122353588144, 5030.698158110488, 5034.471380505068, 5094.7197904115255, 4667.066586682643, 4709.246520556729, 4717.716936983792, 4724.551167639069, 4730.0, 5106.795728170831, 5132.769025393866, 5136.0241554104605, 5153.433122356538, 5179.948200518022, 4721.102990431807, 4865.6107511399005, 4956.504349565014, 4965.602751779849, 5012.24816277554, 4846.442659094249, 4965.1807451770055, 4990.775415106329, 5015.774290156952, 5054.064997975386, 4918.508149185053, 4920.360353154067, 4973.0, 4980.676256043345, 4983.975080124576, 4819.95180048202, 4890.633202509826, 4941.530554597308, 4959.70241785494, 4999.3000979862845, 4134.131832315187, 4150.771707556113, 4159.188958153191, 4208.410822484854, 4208.873733787991, 3653.725970552219, 3662.7069834413182, 3695.667389934919, 3710.18375957289, 3725.590185079639, 4367.45406824147, 4405.867823965286, 4406.537313582027, 4423.778811059434, 4431.778411079433, 5013.749312534432, 5017.774200161001, 5025.447200807908, 5036.345275114285, 5089.796408143707, 4351.956480435155, 4418.381426600278, 4418.8453404130705, 4421.734695918255, 4461.330800379969, 4279.893002674958, 4491.8652440426185, 4506.391637128946, 4509.143262780061, 4525.547445255448, 4895.951040489621, 4898.559129678203, 4946.233333833262, 4954.777035033432, 4994.850154495371, 4936.9259461107395, 5102.387713474258, 5119.436861945109, 5120.359955005624, 5172.689638621695, 4853.927191092066, 4862.975685121552, 4877.195262781602, 4880.487548807466, 4890.779914903766, 4930.260460930889, 4952.628552858478, 4968.4452662941785, 4969.751512424436, 5004.47453017428, 4846.903061938812, 4955.72743499111, 5020.949790502048, 5029.170186919264, 5079.466656001066, 4648.651351148745, 4837.951620483891, 4873.756312184448, 4925.064237794808, 4927.531884470969, 4966.081274964144, 4972.825951091694, 4975.0, 4975.029869175621, 4977.751112444435, 4596.057808149255, 4798.1843086676045, 4902.0, 4911.435184953776, 4952.678075925053, 4928.383952005999, 4960.627952903475, 4960.975195124001, 4977.228529577921, 5027.32131162303, 4848.8302909398, 4850.587700045536, 4854.150523658275, 4883.316335713074, 4915.164422048332], "value": 4624.43450378477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.6761254455911, 573.5612256623682, 580.7764010855819, 586.8738221282423, 603.6106711171298, 35412.2917541649, 39378.606213937856, 39434.21131577374, 39761.4035789463, 39799.80100099503, 39253.21493570127, 39692.0, 39698.40452393209, 39724.80137599308, 39754.20491590167, 7459.850802983937, 7631.313181813635, 7661.463697541174, 7690.6154692265445, 7698.769036928873, 7656.617169141548, 7719.614019299041, 7720.961395193044, 7724.536527808349, 7741.729039483619, 7677.769666909974, 7729.381649468057, 7752.418568607349, 7756.922430775677, 7791.766247012599, 7701.1528731839735, 7714.151443341256, 7716.6527506262355, 7721.575313357763, 7741.148473667892, 7550.546967181932, 7578.317951384347, 7633.0458692663415, 7654.617269136576, 7667.3099421052375, 36589.451158232645, 36973.44539831905, 36982.0, 36989.63010369916, 37045.44431833525, 2204.6252137136726, 2674.4784766970447, 2716.9728302716917, 2739.1782465260344, 2768.224897028835, 27921.86039069812, 28089.0, 28196.71803281982, 28432.431351372856, 29198.562021569694, 3216.903492895217, 3220.3559288142465, 3224.91937701557, 3235.336755965045, 3263.216827961296, 212992.0, 214220.0, 214548.0, 216092.0, 216628.0, 32131.839340803614, 32156.678433215835, 32461.0, 32472.0, 32472.83763581167, 31920.201994949846, 33814.0, 33861.83069084688, 33896.49155262673, 33940.49089263663, 13719.1082579634, 13834.861651383559, 13918.0, 13973.441062357391, 14018.789718154032, 11419.714507137389, 11494.827577586342, 11630.302181868945, 11632.0, 11679.824802627967, 7711.0, 7798.1811909749795, 7807.141214466405, 7862.8427431451055, 7907.051153861458, 3057.6636569977286, 3089.073278016586, 3094.75241980641, 3118.7349075328398, 3132.1230055584474, 799.4643588795522, 830.8326800844823, 833.021200089892, 865.3077537969599, 906.8821053263033, 26416.339591509983, 26760.866195668896, 26948.59577106345, 27141.79450953786, 27210.727892721214, 890.8396488631979, 953.2374100719396, 957.3346524165777, 971.6113554578084, 1026.1636766035658, 14313.85686143146, 14336.784948225784, 14336.93901265241, 14370.425182992563, 14380.85619143816, 399314.0, 404459.0, 405471.0, 405617.0, 406969.0, 47495.0, 48738.75630621895, 48764.0, 48777.75611121922, 49057.264141037915, 1142.6000899685043, 1168.3574034281112, 1172.1853311948284, 1194.814803705427, 1229.9508019679113, 26023.349416263987, 26757.331066723487, 26817.597736033586, 26826.463470730865, 26960.191194264204, 41683.166336673705, 42080.36879446872, 42259.7887010563, 42332.153356933304, 42381.0, 331557.0266445957, 332538.0, 332763.0, 333899.0, 334948.0, 24523.75476245286, 25180.622290665287, 25190.24429267125, 25219.495610087328, 25953.6106958392, 41340.0, 41413.0, 41497.1700565993, 41854.74435766932, 42470.0, 35336.46995295021, 36000.639993599725, 36035.0, 36255.81872090622, 36668.81665591655, 35161.29677406489, 35462.113447164025, 35698.0, 35956.46065309075, 36115.0, 32447.513287300237, 35407.46888796722, 35637.28725425529, 36504.81747591245, 36869.0, 29719.70280297256, 32406.351872961935, 32486.187845304055, 32561.34877302488, 32631.694732210446, 25304.493910121328, 25370.619440708037, 25400.237992860242, 25435.6184657234, 25623.871880640476], "value": 15958.714380882717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.7133536168023, 353.8319298333292, 354.67901549098065, 355.564433568878, 369.14542833340795, 15777.921110394447, 16630.0, 17415.129243537835, 17427.1286435678, 17449.38927137552, 14114.64713382166, 16488.587785305343, 17005.23476443563, 17247.396341128064, 17315.653686926253, 4902.5342592453835, 5073.518015788494, 5109.923351149736, 5123.2315152727015, 5141.768620412072, 3072.4623190941497, 4833.516648335173, 5601.495865372116, 5921.378255283198, 5938.376470470603, 5966.67183304918, 5979.252593425822, 5993.910091348612, 6027.216461859974, 6035.275766907977, 5861.443162899518, 5967.8209653710455, 6011.549133814938, 6032.426919442646, 6050.515958723292, 5124.15451450514, 5125.359330083739, 5158.38099428071, 5230.0, 5238.68567885928, 20108.39674809758, 20494.692579611317, 20554.38336849897, 20601.278955236645, 20617.072231749607, 2002.5594369238745, 2108.599366120432, 2175.010370281518, 2203.250894695811, 2316.096722278313, 13319.533816316383, 13415.060945733803, 13448.663783405493, 13473.595792126252, 13745.518906838313, 1503.2784263553447, 1553.4873491747696, 1573.39424321637, 1576.7634854771875, 1589.3324803582523, 63746.681266593834, 64238.0, 65865.0, 66373.66813165952, 66796.66601667009, 9100.31747618918, 9257.861132083024, 9319.068093190626, 9366.67216647414, 9450.669226577174, 12352.567660131852, 12377.504899804087, 12402.75194496105, 12512.68718282032, 12549.749005019848, 7243.239459856744, 7338.082739657543, 7346.6326683666675, 7449.515781474187, 7458.3758069995865, 7210.747623833246, 7226.205117437078, 7232.168300645388, 7247.891281630779, 7348.338649521462, 5844.26946631671, 5949.0, 6070.2412198475195, 6079.75680972765, 6096.72564734588, 1529.4035326222781, 1585.3103899803623, 1656.3126302584533, 1665.9916700416663, 1723.5001849463515, 792.3027735592642, 819.1153554161491, 899.3922890776006, 923.630547780893, 935.4901578639658, 16195.352185912667, 16913.32346706118, 17141.82858171427, 17211.827881721274, 17308.82691173072, 871.333429926107, 874.1127755328347, 881.1628952495155, 930.9022552632011, 949.3449519831295, 9716.805663886682, 9992.200623950066, 10093.24300677452, 10148.238882083726, 10201.693949181536, 389912.0, 391675.0, 394719.0, 395490.0, 406259.0, 60772.0, 69097.0, 71447.0, 72497.6375118121, 72723.0, 911.3893691226893, 918.3892711347013, 924.0990034716098, 933.1648174883442, 949.093615597103, 15148.318325675591, 15254.771178432555, 15254.771178432555, 15302.158381289137, 15328.540143795704, 24613.384665382793, 33098.5035224467, 33183.83408082944, 33494.0, 34279.657203428644, 41385.37921931234, 42533.78733106315, 43960.780196098814, 44653.55346446494, 44878.0, 7395.630218489162, 7433.628318583941, 7487.101547814297, 7566.659500322388, 7753.0, 11351.716207094889, 11823.231489953125, 11827.290362578273, 11839.28964262147, 11943.283402995849, 9844.655437059668, 9886.604535818487, 10132.13876820449, 10272.22958278147, 10454.58181672755, 9954.352967057119, 10089.133510300619, 10248.897511025092, 10271.435071070864, 10581.576736930436, 10243.48782560884, 10292.0, 10329.483525823529, 10444.63443779464, 10457.163426925676, 7469.215732348025, 7530.924690753022, 7571.621418929141, 7589.354904833151, 7630.7329243476215, 10003.749906252402, 10190.0, 10257.692269231935, 10375.584976600852, 10508.42203678805], "value": 8237.473816143787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.7748121559944, 1393.066645347617, 1457.7886206500057, 1607.0919930239406, 1614.878884083694, 6485.767704136211, 7210.387117095047, 7635.121960974476, 7672.0, 7750.4187185961, 7698.730544430946, 7790.104138024115, 7842.176571460001, 7881.133075361706, 7917.129115797257, 2160.2331172433755, 2202.1081462007915, 2207.8233741300655, 2209.2267706302746, 2209.5139069404704, 2134.5624147049816, 2137.2519618133606, 2141.379000089972, 2142.817860481861, 2154.052217024512, 2144.5710857828417, 2150.8064274215317, 2165.1880544795704, 2179.1283486605407, 2194.868307901523, 1991.9302824401077, 1999.6700544410155, 2007.7691065527433, 2010.3466373428694, 2013.7885522020124, 2090.696848956908, 2092.529180934293, 2093.612681653899, 2105.4104850641843, 2107.6838474228834, 7828.5694286814205, 7948.0, 7948.443608947376, 7972.322352599978, 7976.561289129096, 4468.8882777930485, 4597.287420449802, 4607.14767767964, 4608.216603177468, 4611.193041217807, 2752.270648278208, 2830.377316990259, 2840.61651677023, 2864.240976141324, 2912.9708702912912, 875.6974198554017, 910.2126660438673, 916.6837441082815, 924.5377311344328, 934.1592566689966, 10539.0, 10595.470226488645, 10598.788024239471, 10618.787624247472, 10622.15022798182, 3967.0875698589484, 3985.621365970228, 4038.192361527706, 4058.1477889643506, 4183.811728472226, 8960.551972401354, 9004.729858104267, 9009.324300677476, 9025.458472491671, 9046.411983221069, 4352.368906508538, 4398.472183337956, 4418.094290670405, 4633.258678611406, 4671.416072990876, 3400.812955287483, 4056.0468289951837, 4064.0246340877975, 4150.398192262105, 4242.681798865097, 3417.1115509967585, 3477.6348483409383, 3519.1905861651962, 3522.137076416243, 3586.246888153517, 1153.798085335063, 1166.8891455311732, 1176.5764324843049, 1184.2539200303754, 1184.6860581945791, 688.2394953576227, 745.37760969591, 754.35125791819, 816.2775943290231, 816.9877451838228, 4987.501249874984, 5210.505002024802, 5213.165893457029, 5230.555402790729, 5246.973765131226, 393.3117045170951, 395.170142700327, 399.4328054163095, 401.2536681771902, 401.6405317241053, 3336.4661654135707, 3475.826208689606, 3510.4558793387064, 3512.473129030615, 3535.911602209965, 9308.906910930804, 9738.610455581838, 9755.463449510204, 9759.414435133915, 9761.0, 9491.857622135674, 9550.0, 9575.952120239353, 9619.422834629944, 9629.614815407305, 6936.7572134975035, 7326.267373262631, 7334.119905611254, 7379.741709040158, 7422.29488198631, 5214.843554693365, 5248.711320877388, 5273.630845840754, 5352.5985551084605, 5372.1941708744, 8656.350773692124, 8665.783355416164, 8977.820443591223, 9037.954810225907, 9106.408083474553, 9020.548972551214, 9100.135487128713, 9155.816883662423, 9208.217301529445, 9231.261499079923, 5713.400092990342, 6208.441240288395, 6432.581882177644, 6628.204615446178, 6803.659817009031, 7437.181909990005, 7454.329110380092, 7462.403007759474, 7465.850682986201, 7493.175750667531, 6608.240052394036, 6762.6280554568, 6778.118844550177, 6794.42247408956, 6943.930560694328, 6224.0, 6258.9374106260175, 6350.872982540231, 6378.872422551616, 6394.552381333262, 5931.08068249422, 5932.13983972313, 5938.198343223609, 5951.16683664296, 5992.280926288873, 4269.935950960676, 4410.911781764283, 4412.889677758082, 4428.180786554498, 4456.064226512339, 4397.538258482813, 4437.844675436344, 4501.6848820582245, 4505.819767209275, 4516.074204787945], "value": 3973.5546589411742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.76138156944927, 289.9608552845366, 294.4244002974185, 295.3163426667265, 296.32290216854494, 4782.33047373368, 4851.514848515147, 4877.634177436693, 4941.752912354382, 4962.40451145863, 4879.3656824612835, 4879.609631229502, 4887.657863949525, 4899.069176856395, 4912.631552633549, 3764.832901800437, 3790.5072340595684, 3819.255245227189, 3820.4269359596005, 3830.157365379612, 3706.759060661062, 3824.9808750956345, 3836.865709700161, 3847.442120892469, 3860.9420858687004, 3787.299349620329, 3791.279656865187, 3794.3739283018267, 3798.8290526926216, 3801.486799282089, 3768.6419790119894, 3769.4157405602177, 3806.4480650305827, 3822.388417853158, 3829.329867273216, 3349.363620912019, 3359.395308844407, 3362.7982321060813, 3376.6285708572036, 3378.5303393024114, 4535.750533720644, 4832.782524786393, 4875.366202393701, 4882.877928051792, 4884.853454396374, 4244.511881133678, 4253.404523366731, 4271.611726189001, 4277.529471758104, 4282.678799090081, 5120.129577971754, 5142.020322175952, 5143.922841157386, 5168.534831865112, 5173.0688476074665, 3533.2580158166816, 3608.963910360915, 3610.530631017977, 3615.403458429356, 3618.5115009473648, 5314.787408503656, 5318.946810531884, 5321.148616221386, 5321.855801002765, 5328.653637513588, 3626.5285512883156, 3641.308151451216, 3655.6527129922615, 3661.6338366163172, 3666.2300916807235, 3694.7783133012103, 3706.5181526401393, 3708.1841994761107, 3714.647108524686, 3735.4957080793747, 4033.8100260423244, 4212.136512015029, 4261.701680882308, 4270.444842170498, 4298.78506074695, 5081.74591270435, 5107.803644432855, 5114.0, 5114.514121158484, 5121.231815227746, 1207.4506099724604, 1242.1491278474275, 1273.2996851731511, 1276.495784165268, 1276.961691149267, 796.5658715999793, 807.3097501636134, 812.3054788156041, 813.3940214540087, 818.2717381530442, 4121.5466298707115, 4121.876343709693, 4132.648724858421, 4139.379093136054, 4143.18263580768, 4703.247480403119, 4716.1510928033285, 4733.219018861918, 4733.715977041388, 4739.03330118004, 4115.506139263308, 4157.147784704189, 4185.9581404185565, 4201.831926722897, 4219.2194444027955, 2295.6900818389636, 2536.9978858350846, 2545.8090643201836, 2558.684390626486, 2592.3519120219944, 4521.344405061248, 4522.909541809146, 4541.296099104644, 4562.977185114053, 4592.67851250416, 4767.95232047682, 4775.832845850378, 4789.473157952622, 4830.468648448667, 4844.89247177479, 4431.246688062973, 4623.31847528426, 4625.606823420047, 4648.651351148677, 4659.161350956792, 4691.648126390603, 4742.288656701385, 4782.0914026334885, 4787.473377928355, 4796.409938633099, 4674.218839790319, 4690.15577196108, 4691.648126390466, 4711.175544279668, 4719.221328480762, 4620.5148459411275, 4628.213203755437, 4824.807007719652, 5239.214117882349, 5245.0, 3661.7436779425184, 3691.9630803692694, 3692.1323488980606, 3700.463432802175, 3705.4256590228556, 5103.821366252163, 5358.812441564526, 5410.810621628224, 5417.187421886749, 5424.484673955968, 5024.4975502450925, 5166.664166829144, 5167.302414174038, 5180.585553155664, 5183.663061900965, 5172.293143262789, 5188.818391356284, 5190.480951904779, 5199.324087868704, 5215.869603259949, 4927.8275260367145, 5080.212567052113, 5082.872928176826, 5137.563307118937, 5146.47822566932, 5166.3800343958965, 5191.610629202901, 5194.870128246824, 5225.451327610698, 5236.293100431393, 5111.79552817898, 5115.744212789271, 5123.666961647481, 5124.923126153185, 5146.176611742103], "value": 3752.5307826669928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.52237851662403, 500.8847964968055, 506.7137067556831, 537.4920699938557, 537.6397813464978, 10494.265401421893, 11058.0, 11138.164637652178, 11142.27575207611, 11166.106711463073, 11294.040006599429, 11350.489227984739, 11379.0, 12318.876811231885, 12809.743805123891, 609.4301827791007, 752.578556008637, 786.1941509952287, 792.2869417524246, 794.2295972906301, 772.8724760414525, 773.6247919758913, 773.6943907156669, 774.6204359863683, 782.8160382310152, 802.4864086984335, 804.0833449867156, 804.9074356449024, 805.2028491793142, 806.2219957740779, 787.5943888897194, 794.0114557376104, 796.7410591557767, 798.3892322373389, 804.9718259860906, 588.608575297431, 589.4047012517345, 589.5813972079828, 591.204829504316, 591.9556033297476, 12169.817452738216, 12369.93815030919, 12389.318587477685, 12401.379931003414, 12410.193337433127, 12202.938985305105, 12219.572314968933, 12653.936730316382, 12691.555795547112, 12732.917701995342, 8867.911320886773, 8892.777680558038, 9188.127127922837, 9728.319017668766, 9996.0, 3249.333886553251, 3268.444364458048, 3303.8678452861855, 3363.0751543325537, 3406.097384193191, 49419.50580494221, 50966.0, 50979.74510127425, 61849.690751546404, 63286.0, 9528.857067143997, 9568.4737339447, 9626.90373096274, 9672.274579406572, 10035.899641003643, 16605.58486037859, 16901.070441125612, 17388.391406300718, 17604.471865844047, 18511.259549618135, 6304.117423560705, 6417.935820641827, 6531.836704082436, 6811.659417029129, 6814.693338799766, 3395.3379091077004, 3581.3732596795458, 3593.2274560969518, 3610.3140403323287, 3687.502187204747, 2714.1993112031996, 2810.9156725298276, 2813.1560531840364, 2821.0549465929143, 2831.0232969625445, 457.3779659662922, 460.5630531574792, 464.8001359415416, 466.44260109169215, 469.68061718031385, 423.686472010716, 425.5786771096592, 494.54007772771666, 511.9692818430906, 524.2372348233312, 6772.8984065239065, 6779.559328643622, 6805.251422343637, 6830.487713421513, 6832.555883867532, 466.16556364108544, 495.55152586908906, 505.290067455226, 541.2206422751226, 544.8855740294504, 3320.053784671357, 3335.09952312879, 3350.5644266245718, 3362.0922350965593, 3409.3863104641405, 61365.386346135965, 89561.55219223863, 91563.54218228866, 91822.0, 92659.0, 50543.0, 61116.0, 68957.65521172361, 76380.0, 80229.0, 69201.96197057048, 69475.30524694688, 70302.64848675724, 70912.0, 71330.99999999897, 6389.584676995981, 6439.484841212598, 6442.323556026738, 6455.870882582228, 6489.5781774184525, 31027.689723103384, 35657.64342356543, 43377.0, 44141.558584413746, 44202.55797441985, 55449.44550554443, 61466.385336147854, 61853.69073154785, 61883.690581546805, 62383.0, 8691.65279381697, 8791.428557143765, 8904.643814247358, 9001.0, 9019.233365164035, 9541.332106752461, 9725.708228753148, 9849.950750246202, 9885.50572471388, 9894.703158905244, 8729.476231426135, 8773.166549177819, 8833.646654133763, 8989.01120876716, 9069.22911552499, 9282.814343712953, 9660.75848103803, 9800.264980126662, 10088.747781305527, 10098.0, 9402.576884040098, 9517.381370210915, 9828.361156524803, 9901.50492475359, 10264.794704105727, 8121.1472795358, 8143.307818835466, 8552.700655477029, 8646.308295336232, 8859.645614175619, 7249.963750181215, 7264.854702905806, 7288.409059219585, 7531.322181003736, 7556.4710470266555], "value": 5810.344363741634, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 141.0, 161.0, 191.0, 130.0, 167.0, 163.0, 133.0, 187.0, 134.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 184.0, 162.0, 167.0, 163.0, 163.0, 162.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 173.0, 77.0, 76.0, 75.0, 77.0, 160.0, 77.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 134.0, 85.0, 87.0, 86.0, 132.0, 86.0, 87.0, 138.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 68.0, 66.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 86.0, 86.0, 83.0, 85.0, 87.0, 118.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 157.0, 139.0, 134.0, 142.0, 134.0, 132.0, 153.0, 136.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 174.0, 169.0, 172.0, 168.0, 168.0, 169.0, 168.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 66.0, 68.0, 71.0, 71.0, 68.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 16:57:47 INFO - Return code: 0 16:57:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:57:47 ERROR - # TBPL SUCCESS # 16:57:47 INFO - Running post-action listener: _resource_record_post_action 16:57:47 INFO - ##### 16:57:47 INFO - ##### Finished run-tests step (success) 16:57:47 INFO - ##### 16:57:47 INFO - Running post-run listener: _resource_record_post_run 16:57:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287014912; Read time: 12; Write time: 233548 16:57:47 INFO - TinderboxPrint: CPU usage
13.5% 16:57:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:57:47 INFO - TinderboxPrint: I/O write bytes / time
287,014,912 / 233,548 16:57:47 INFO - TinderboxPrint: CPU idle
8,261.1 (86.5%) 16:57:47 INFO - TinderboxPrint: CPU user
1,233.2 (12.9%) 16:57:47 INFO - TinderboxPrint: Swap in / out
0 / 0 16:57:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1466368; Read time: 0; Write time: 48 16:57:47 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285548544; Read time: 12; Write time: 233500 16:57:47 INFO - Running post-run listener: _upload_blobber_files 16:57:47 INFO - Blob upload gear active. 16:57:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:47 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 16:57:47 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'] 16:57:47 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 16:57:48 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:48 INFO - (blobuploader) - INFO - Done attempting. 16:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:49 INFO - (blobuploader) - INFO - Done attempting. 16:57:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:57:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:53 INFO - (blobuploader) - INFO - Done attempting. 16:57:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:57:53 INFO - Return code: 0 16:57:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:57:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:57:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c400f5986be7303225e51b2fb942834daf33b736caf42d9179def2d973ea329d01cbe2ea4676939ed6f07e7d453872b35856fd5132b665036245c60c6028ec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d629c3b82e28f452e2b19aa305583d9bbdf194d0385d8d202cb5620f67e5ba44501c83e7db2aa894a577da6663e8705ae2f460563fe5da9aeca6bb6d3e5fdc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30f0e73f9d98936796f4cab1508c14263bdfe6f0b03d4f238ed960e6201a488e0143bef245d8e2c6202f4a1a70f931ae939be7ac79d8598b804aeb2a76b44a"} 16:57:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:57:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:57:53 INFO - Contents: 16:57:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c400f5986be7303225e51b2fb942834daf33b736caf42d9179def2d973ea329d01cbe2ea4676939ed6f07e7d453872b35856fd5132b665036245c60c6028ec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d629c3b82e28f452e2b19aa305583d9bbdf194d0385d8d202cb5620f67e5ba44501c83e7db2aa894a577da6663e8705ae2f460563fe5da9aeca6bb6d3e5fdc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30f0e73f9d98936796f4cab1508c14263bdfe6f0b03d4f238ed960e6201a488e0143bef245d8e2c6202f4a1a70f931ae939be7ac79d8598b804aeb2a76b44a"} 16:57:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:57:53 INFO - Copying logs to upload dir... 16:57:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:57:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.946398 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 16:57:53.441940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:57:53.445733) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 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/c400f5986be7303225e51b2fb942834daf33b736caf42d9179def2d973ea329d01cbe2ea4676939ed6f07e7d453872b35856fd5132b665036245c60c6028ec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d629c3b82e28f452e2b19aa305583d9bbdf194d0385d8d202cb5620f67e5ba44501c83e7db2aa894a577da6663e8705ae2f460563fe5da9aeca6bb6d3e5fdc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30f0e73f9d98936796f4cab1508c14263bdfe6f0b03d4f238ed960e6201a488e0143bef245d8e2c6202f4a1a70f931ae939be7ac79d8598b804aeb2a76b44a"} build_url:https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/aK4SUaYJTwWMQ9f0kZQjUw/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/c400f5986be7303225e51b2fb942834daf33b736caf42d9179def2d973ea329d01cbe2ea4676939ed6f07e7d453872b35856fd5132b665036245c60c6028ec36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d629c3b82e28f452e2b19aa305583d9bbdf194d0385d8d202cb5620f67e5ba44501c83e7db2aa894a577da6663e8705ae2f460563fe5da9aeca6bb6d3e5fdc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/af30f0e73f9d98936796f4cab1508c14263bdfe6f0b03d4f238ed960e6201a488e0143bef245d8e2c6202f4a1a70f931ae939be7ac79d8598b804aeb2a76b44a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:57:53.472445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:57:53.472823) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1465515431.820583-243691115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:57:53.558492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:57:53.559219) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:57:53.559951) ========= ========= Total master_lag: 0.18 =========