builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1466497938.16 results: success (0) buildid: 20160621003900 builduid: a352f56d2eb34dc3ba6f7dc114a2310e revision: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.158793) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.159347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.159629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.200183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.200470) ========= 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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 01:32:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.1M=0s 2016-06-21 01:32:18 (41.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083608 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.463605) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.463921) ========= 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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020048 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:18.504430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:32:18.504743) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da --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 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da --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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 01:32:18,847 truncating revision to first 12 chars 2016-06-21 01:32:18,847 Setting DEBUG logging. 2016-06-21 01:32:18,847 attempt 1/10 2016-06-21 01:32:18,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21a0421ca9b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 01:32:19,587 unpacking tar archive at: fx-team-21a0421ca9b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.125213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:32:19.644943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.645211) ========= script_repo_revision: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.645591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.645853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:32:19.653623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 01:32:19.653885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:20 INFO - MultiFileLogger online at 20160621 01:32:20 in /builds/slave/test 01:32:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 01:32:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:20 INFO - {'append_to_log': False, 01:32:20 INFO - 'base_work_dir': '/builds/slave/test', 01:32:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:32:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:20 INFO - 'branch': 'Fx-Team-Non-PGO', 01:32:20 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:20 INFO - 'config_files': ('talos/linux_config.py',), 01:32:20 INFO - 'default_actions': ('clobber', 01:32:20 INFO - 'read-buildbot-config', 01:32:20 INFO - 'download-and-extract', 01:32:20 INFO - 'populate-webroot', 01:32:20 INFO - 'create-virtualenv', 01:32:20 INFO - 'install', 01:32:20 INFO - 'run-tests'), 01:32:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:20 INFO - 'download_minidump_stackwalk': True, 01:32:20 INFO - 'download_symbols': 'ondemand', 01:32:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:20 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:20 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:20 INFO - 'installer_path': 'installer.exe', 01:32:20 INFO - 'log_level': 'info', 01:32:20 INFO - 'log_name': 'talos', 01:32:20 INFO - 'log_to_console': True, 01:32:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:20 INFO - 'opt_config_files': (), 01:32:20 INFO - 'pip_index': False, 01:32:20 INFO - 'sps_profile': False, 01:32:20 INFO - 'sps_profile_interval': 0, 01:32:20 INFO - 'suite': 'dromaeojs', 01:32:20 INFO - 'system_bits': '32', 01:32:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:20 INFO - 'title': 'talos-linux64-ix-032', 01:32:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:20 INFO - 'use_talos_json': True, 01:32:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:20 INFO - 'work_dir': 'build'} 01:32:20 INFO - ##### 01:32:20 INFO - ##### Running clobber step. 01:32:20 INFO - ##### 01:32:20 INFO - Running pre-action listener: _resource_record_pre_action 01:32:20 INFO - Running main action method: clobber 01:32:20 INFO - rmtree: /builds/slave/test/build 01:32:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:21 INFO - Running post-action listener: _resource_record_post_action 01:32:21 INFO - ##### 01:32:21 INFO - ##### Finished clobber step (success) 01:32:21 INFO - ##### 01:32:21 INFO - ##### 01:32:21 INFO - ##### Running read-buildbot-config step. 01:32:21 INFO - ##### 01:32:21 INFO - Running pre-action listener: _resource_record_pre_action 01:32:21 INFO - Running main action method: read_buildbot_config 01:32:21 INFO - Using buildbot properties: 01:32:21 INFO - { 01:32:21 INFO - "project": "", 01:32:21 INFO - "product": "firefox", 01:32:21 INFO - "script_repo_revision": "production", 01:32:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:32:21 INFO - "repository": "", 01:32:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:32:21 INFO - "buildid": "20160621003900", 01:32:21 INFO - "pgo_build": "False", 01:32:21 INFO - "basedir": "/builds/slave/test", 01:32:21 INFO - "buildnumber": 3094, 01:32:21 INFO - "slavename": "talos-linux64-ix-032", 01:32:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:32:21 INFO - "platform": "ubuntu64_hw", 01:32:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:32:21 INFO - "branch": "fx-team", 01:32:21 INFO - "repo_path": "integration/fx-team", 01:32:21 INFO - "revision": "21a0421ca9b0e39a28b1ab1875b6ac33f06f23da", 01:32:21 INFO - "stage_platform": "linux64", 01:32:21 INFO - "builduid": "a352f56d2eb34dc3ba6f7dc114a2310e", 01:32:21 INFO - "slavebuilddir": "test" 01:32:21 INFO - } 01:32:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:32:21 INFO - Running post-action listener: _resource_record_post_action 01:32:21 INFO - ##### 01:32:21 INFO - ##### Finished read-buildbot-config step (success) 01:32:21 INFO - ##### 01:32:21 INFO - ##### 01:32:21 INFO - ##### Running download-and-extract step. 01:32:21 INFO - ##### 01:32:21 INFO - Running pre-action listener: _resource_record_pre_action 01:32:21 INFO - Running main action method: download_and_extract 01:32:21 INFO - mkdir: /builds/slave/test/build/tests 01:32: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')]} 01:32:21 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:23 INFO - Downloaded 1361 bytes. 01:32:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:23 INFO - Using the following test package requirements: 01:32:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:32:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'jsshell-linux-x86_64.zip'], 01:32:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32:23 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')]} 01:32:23 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:24 INFO - Downloaded 22654960 bytes. 01:32:24 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'] 01:32:24 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 01:32:25 INFO - Return code: 0 01:32:25 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 01:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:25 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:26 INFO - Downloaded 22654960 bytes. 01:32:26 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'] 01:32:26 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 01:32:28 INFO - Return code: 0 01:32:28 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')]} 01:32:28 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:32:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:32:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:29 INFO - Downloaded 14405384 bytes. 01:32:29 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'] 01:32:29 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 01:32:29 INFO - Return code: 0 01:32: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')]} 01:32:29 INFO - https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-_Ecgh6RLWegNKs7np98Q/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 01:32:31 INFO - Downloaded 56233053 bytes. 01:32:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:31 INFO - mkdir: /builds/slave/test/properties 01:32:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:32:31 INFO - Writing to file /builds/slave/test/properties/build_url 01:32:31 INFO - Contents: 01:32:31 INFO - build_url:https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:32:32 INFO - Running post-action listener: _resource_record_post_action 01:32:32 INFO - Running post-action listener: set_extra_try_arguments 01:32:32 INFO - ##### 01:32:32 INFO - ##### Finished download-and-extract step (success) 01:32:32 INFO - ##### 01:32:32 INFO - ##### 01:32:32 INFO - ##### Running populate-webroot step. 01:32:32 INFO - ##### 01:32:32 INFO - Running pre-action listener: _resource_record_pre_action 01:32:32 INFO - Running main action method: populate_webroot 01:32:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:32:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:32:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:32:32 INFO - '--tppagecycles', 01:32:32 INFO - '7'], 01:32:32 INFO - 'tests': ['tsvgm']}}, 01:32:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:32:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:32:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:32:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:32:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:32:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['damp', 'tps']}, 01:32:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'tests': ['damp', 'tps']}, 01:32:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['dromaeo_dom']}, 01:32:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:32:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['basic_compositor_video']}, 01:32:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:32:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'other-e10s': {'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['a11yr', 01:32:32 INFO - 'ts_paint', 01:32:32 INFO - 'tpaint', 01:32:32 INFO - 'sessionrestore', 01:32:32 INFO - 'sessionrestore_no_auto_restore', 01:32:32 INFO - 'tabpaint']}, 01:32:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['tsvgx', 01:32:32 INFO - 'tsvgr_opacity', 01:32:32 INFO - 'tart', 01:32:32 INFO - 'tscrollx', 01:32:32 INFO - 'cart']}, 01:32:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:32:32 INFO - 'tsvgr_opacity', 01:32:32 INFO - 'tart', 01:32:32 INFO - 'tscrollx', 01:32:32 INFO - 'cart']}, 01:32:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'talos_options': ['--disable-e10s'], 01:32:32 INFO - 'tests': ['tp5o']}, 01:32:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'tests': ['tp5o']}, 01:32:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'talos_options': ['--disable-e10s', 01:32:32 INFO - '--xperf_path', 01:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:32 INFO - 'tests': ['tp5n']}, 01:32:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:32:32 INFO - 'talos_options': ['--xperf_path', 01:32:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:32:32 INFO - 'tests': ['tp5n']}}, 01:32:32 INFO - 'talos.zip': {'path': '', 01:32:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:32:32 INFO - Running post-action listener: _resource_record_post_action 01:32:32 INFO - ##### 01:32:32 INFO - ##### Finished populate-webroot step (success) 01:32:32 INFO - ##### 01:32:32 INFO - ##### 01:32:32 INFO - ##### Running create-virtualenv step. 01:32:32 INFO - ##### 01:32:32 INFO - Running pre-action listener: _resource_record_pre_action 01:32:32 INFO - Running main action method: create_virtualenv 01:32:32 INFO - Creating virtualenv /builds/slave/test/build/venv 01:32:32 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 01:32:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:32:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:32:32 INFO - Using real prefix '/usr' 01:32:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:32:32 INFO - Installing distribute.............................................................................................................................................................................................done. 01:32:34 INFO - Installing pip.................done. 01:32:34 INFO - Return code: 0 01:32:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:34 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:34 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 01:32:34 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 01:32:34 INFO - Using env: {'DISPLAY': ':0', 01:32:34 INFO - 'HOME': '/home/cltbld', 01:32:34 INFO - 'LANG': 'en_US.UTF-8', 01:32:34 INFO - 'LANGUAGE': 'en_US:en', 01:32:34 INFO - 'LOGNAME': 'cltbld', 01:32:34 INFO - 'MAIL': '/var/mail/cltbld', 01:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:34 INFO - 'MOZ_NO_REMOTE': '1', 01:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:34 INFO - 'NO_EM_RESTART': '1', 01:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:34 INFO - 'PWD': '/builds/slave/test', 01:32:34 INFO - 'SHELL': '/bin/bash', 01:32:34 INFO - 'SHLVL': '1', 01:32:34 INFO - 'TERM': 'linux', 01:32:34 INFO - 'TMOUT': '86400', 01:32:34 INFO - 'USER': 'cltbld', 01:32:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:34 INFO - '_': '/tools/buildbot/bin/python'} 01:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:34 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 01:32:34 INFO - Cleaning up... 01:32:34 INFO - Return code: 0 01:32:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:34 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:34 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 01:32:34 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 01:32:34 INFO - Using env: {'DISPLAY': ':0', 01:32:34 INFO - 'HOME': '/home/cltbld', 01:32:34 INFO - 'LANG': 'en_US.UTF-8', 01:32:34 INFO - 'LANGUAGE': 'en_US:en', 01:32:34 INFO - 'LOGNAME': 'cltbld', 01:32:34 INFO - 'MAIL': '/var/mail/cltbld', 01:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:34 INFO - 'MOZ_NO_REMOTE': '1', 01:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:34 INFO - 'NO_EM_RESTART': '1', 01:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:34 INFO - 'PWD': '/builds/slave/test', 01:32:34 INFO - 'SHELL': '/bin/bash', 01:32:34 INFO - 'SHLVL': '1', 01:32:34 INFO - 'TERM': 'linux', 01:32:34 INFO - 'TMOUT': '86400', 01:32:34 INFO - 'USER': 'cltbld', 01:32:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:34 INFO - '_': '/tools/buildbot/bin/python'} 01:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:35 INFO - Downloading/unpacking psutil>=3.1.1 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:37 INFO - Installing collected packages: psutil 01:32:37 INFO - Running setup.py install for psutil 01:32:37 INFO - building 'psutil._psutil_linux' extension 01:32:37 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 01:32:37 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 01:32:37 INFO - building 'psutil._psutil_posix' extension 01:32:37 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 01:32:37 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 01:32:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:37 INFO - Successfully installed psutil 01:32:37 INFO - Cleaning up... 01:32:37 INFO - Return code: 0 01:32:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:32:37 INFO - Using env: {'DISPLAY': ':0', 01:32:37 INFO - 'HOME': '/home/cltbld', 01:32:37 INFO - 'LANG': 'en_US.UTF-8', 01:32:37 INFO - 'LANGUAGE': 'en_US:en', 01:32:37 INFO - 'LOGNAME': 'cltbld', 01:32:37 INFO - 'MAIL': '/var/mail/cltbld', 01:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:37 INFO - 'MOZ_NO_REMOTE': '1', 01:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:37 INFO - 'NO_EM_RESTART': '1', 01:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:37 INFO - 'PWD': '/builds/slave/test', 01:32:37 INFO - 'SHELL': '/bin/bash', 01:32:37 INFO - 'SHLVL': '1', 01:32:37 INFO - 'TERM': 'linux', 01:32:37 INFO - 'TMOUT': '86400', 01:32:37 INFO - 'USER': 'cltbld', 01:32:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:37 INFO - '_': '/tools/buildbot/bin/python'} 01:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32: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 01:32:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:39 INFO - Installing collected packages: mozsystemmonitor 01:32:39 INFO - Running setup.py install for mozsystemmonitor 01:32:39 INFO - Successfully installed mozsystemmonitor 01:32:39 INFO - Cleaning up... 01:32:39 INFO - Return code: 0 01:32:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:32:39 INFO - Using env: {'DISPLAY': ':0', 01:32:39 INFO - 'HOME': '/home/cltbld', 01:32:39 INFO - 'LANG': 'en_US.UTF-8', 01:32:39 INFO - 'LANGUAGE': 'en_US:en', 01:32:39 INFO - 'LOGNAME': 'cltbld', 01:32:39 INFO - 'MAIL': '/var/mail/cltbld', 01:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:39 INFO - 'MOZ_NO_REMOTE': '1', 01:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:39 INFO - 'NO_EM_RESTART': '1', 01:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:39 INFO - 'PWD': '/builds/slave/test', 01:32:39 INFO - 'SHELL': '/bin/bash', 01:32:39 INFO - 'SHLVL': '1', 01:32:39 INFO - 'TERM': 'linux', 01:32:39 INFO - 'TMOUT': '86400', 01:32:39 INFO - 'USER': 'cltbld', 01:32:39 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:39 INFO - '_': '/tools/buildbot/bin/python'} 01:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:40 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:42 INFO - warning: no files found matching '*.txt' 01:32:42 INFO - no previously-included directories found matching 'build' 01:32:42 INFO - no previously-included directories found matching 'dist' 01:32:42 INFO - no previously-included directories found matching '.git*' 01:32:42 INFO - Installing collected packages: jsonschema, functools32 01:32:42 INFO - Running setup.py install for functools32 01:32:42 INFO - warning: no files found matching '*.txt' 01:32:42 INFO - no previously-included directories found matching 'build' 01:32:42 INFO - no previously-included directories found matching 'dist' 01:32:42 INFO - no previously-included directories found matching '.git*' 01:32:42 INFO - Successfully installed jsonschema functools32 01:32:42 INFO - Cleaning up... 01:32:42 INFO - Return code: 0 01:32:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:32:42 INFO - Using env: {'DISPLAY': ':0', 01:32:42 INFO - 'HOME': '/home/cltbld', 01:32:42 INFO - 'LANG': 'en_US.UTF-8', 01:32:42 INFO - 'LANGUAGE': 'en_US:en', 01:32:42 INFO - 'LOGNAME': 'cltbld', 01:32:42 INFO - 'MAIL': '/var/mail/cltbld', 01:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:42 INFO - 'MOZ_NO_REMOTE': '1', 01:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:42 INFO - 'NO_EM_RESTART': '1', 01:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:42 INFO - 'PWD': '/builds/slave/test', 01:32:42 INFO - 'SHELL': '/bin/bash', 01:32:42 INFO - 'SHLVL': '1', 01:32:42 INFO - 'TERM': 'linux', 01:32:42 INFO - 'TMOUT': '86400', 01:32:42 INFO - 'USER': 'cltbld', 01:32:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:42 INFO - '_': '/tools/buildbot/bin/python'} 01:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:42 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:44 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:45 INFO - Downloading docopt-0.6.1.tar.gz 01:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:45 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:45 INFO - Running setup.py install for blobuploader 01:32:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:45 INFO - Running setup.py install for requests 01:32:45 INFO - Running setup.py install for docopt 01:32:45 INFO - Successfully installed blobuploader requests docopt 01:32:45 INFO - Cleaning up... 01:32:45 INFO - Return code: 0 01:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:45 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:45 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 01:32:45 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 01:32:45 INFO - Using env: {'DISPLAY': ':0', 01:32:45 INFO - 'HOME': '/home/cltbld', 01:32:45 INFO - 'LANG': 'en_US.UTF-8', 01:32:45 INFO - 'LANGUAGE': 'en_US:en', 01:32:45 INFO - 'LOGNAME': 'cltbld', 01:32:45 INFO - 'MAIL': '/var/mail/cltbld', 01:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:45 INFO - 'MOZ_NO_REMOTE': '1', 01:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:45 INFO - 'NO_EM_RESTART': '1', 01:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:45 INFO - 'PWD': '/builds/slave/test', 01:32:45 INFO - 'SHELL': '/bin/bash', 01:32:45 INFO - 'SHLVL': '1', 01:32:45 INFO - 'TERM': 'linux', 01:32:45 INFO - 'TMOUT': '86400', 01:32:45 INFO - 'USER': 'cltbld', 01:32:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:45 INFO - '_': '/tools/buildbot/bin/python'} 01:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:46 INFO - Running setup.py (path:/tmp/pip-TdmQMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:46 INFO - Running setup.py (path:/tmp/pip-WuvjBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:46 INFO - Running setup.py (path:/tmp/pip-5XYpzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:46 INFO - Running setup.py (path:/tmp/pip-ZV5ee9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:46 INFO - Running setup.py (path:/tmp/pip-pmIwdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:46 INFO - Running setup.py (path:/tmp/pip-2Vv5sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:46 INFO - Running setup.py (path:/tmp/pip-8jbgYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:46 INFO - Running setup.py (path:/tmp/pip-FCMqlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:46 INFO - Running setup.py (path:/tmp/pip-WsTOIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:46 INFO - Running setup.py (path:/tmp/pip-b3U7Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:46 INFO - Running setup.py (path:/tmp/pip-l1vmTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:46 INFO - Running setup.py (path:/tmp/pip-h1Kw60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:47 INFO - Running setup.py (path:/tmp/pip-ejW4Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:47 INFO - Running setup.py (path:/tmp/pip-Qv355q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:47 INFO - Running setup.py (path:/tmp/pip-9mAkOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:47 INFO - Running setup.py (path:/tmp/pip-aA4a9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:47 INFO - Running setup.py (path:/tmp/pip-Yom2dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:47 INFO - Running setup.py install for manifestparser 01:32:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:47 INFO - Running setup.py install for mozcrash 01:32:47 INFO - Running setup.py install for mozdebug 01:32:47 INFO - Running setup.py install for mozdevice 01:32:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:47 INFO - Running setup.py install for mozfile 01:32:47 INFO - Running setup.py install for mozhttpd 01:32:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:47 INFO - Running setup.py install for mozinfo 01:32:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for mozInstall 01:32:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for mozleak 01:32:48 INFO - Running setup.py install for mozlog 01:32:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for moznetwork 01:32:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for mozprocess 01:32:48 INFO - Running setup.py install for mozprofile 01:32:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for mozrunner 01:32:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:48 INFO - Running setup.py install for mozscreenshot 01:32:48 INFO - Running setup.py install for moztest 01:32:49 INFO - Running setup.py install for mozversion 01:32:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:49 INFO - Cleaning up... 01:32:49 INFO - Return code: 0 01:32:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:49 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:49 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 01:32:49 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 01:32:49 INFO - Using env: {'DISPLAY': ':0', 01:32:49 INFO - 'HOME': '/home/cltbld', 01:32:49 INFO - 'LANG': 'en_US.UTF-8', 01:32:49 INFO - 'LANGUAGE': 'en_US:en', 01:32:49 INFO - 'LOGNAME': 'cltbld', 01:32:49 INFO - 'MAIL': '/var/mail/cltbld', 01:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:49 INFO - 'MOZ_NO_REMOTE': '1', 01:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:49 INFO - 'NO_EM_RESTART': '1', 01:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:49 INFO - 'PWD': '/builds/slave/test', 01:32:49 INFO - 'SHELL': '/bin/bash', 01:32:49 INFO - 'SHLVL': '1', 01:32:49 INFO - 'TERM': 'linux', 01:32:49 INFO - 'TMOUT': '86400', 01:32:49 INFO - 'USER': 'cltbld', 01:32:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:49 INFO - '_': '/tools/buildbot/bin/python'} 01:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:49 INFO - Running setup.py (path:/tmp/pip-fvPDzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:49 INFO - Running setup.py (path:/tmp/pip-FK4hSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:49 INFO - Running setup.py (path:/tmp/pip-fXcP0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:49 INFO - Running setup.py (path:/tmp/pip-IXkNjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:49 INFO - Running setup.py (path:/tmp/pip-RpIjsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:49 INFO - Running setup.py (path:/tmp/pip-aMz583-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:49 INFO - Running setup.py (path:/tmp/pip-EVC3VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:49 INFO - Running setup.py (path:/tmp/pip-WydJwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:49 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)) 01:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:49 INFO - Running setup.py (path:/tmp/pip-EiTt4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:50 INFO - Running setup.py (path:/tmp/pip-Sp21gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:50 INFO - Running setup.py (path:/tmp/pip-FK0Knl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:50 INFO - Running setup.py (path:/tmp/pip-Git8l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:50 INFO - Running setup.py (path:/tmp/pip-YiKcJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:50 INFO - Running setup.py (path:/tmp/pip-9XQEmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:50 INFO - Running setup.py (path:/tmp/pip-WkWk5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:50 INFO - Running setup.py (path:/tmp/pip-hT4nqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:50 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)) 01:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:50 INFO - Running setup.py (path:/tmp/pip-MRbEz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:50 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)) 01:32:50 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)) 01:32:50 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)) 01:32:50 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)) 01:32:50 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)) 01:32:50 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)) 01:32:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:52 INFO - Downloading blessings-1.6.tar.gz 01:32:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:52 INFO - Installing collected packages: blessings 01:32:52 INFO - Running setup.py install for blessings 01:32:52 INFO - Successfully installed blessings 01:32:52 INFO - Cleaning up... 01:32:52 INFO - Return code: 0 01:32:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:52 INFO - Reading from file tmpfile_stdout 01:32:52 INFO - Current package versions: 01:32:52 INFO - argparse == 1.2.1 01:32:52 INFO - blessings == 1.6 01:32:52 INFO - blobuploader == 1.2.4 01:32:52 INFO - docopt == 0.6.1 01:32:52 INFO - functools32 == 3.2.3-2 01:32:52 INFO - jsonschema == 2.5.1 01:32:52 INFO - manifestparser == 1.1 01:32:52 INFO - mozInstall == 1.12 01:32:52 INFO - mozcrash == 0.17 01:32:52 INFO - mozdebug == 0.1 01:32:52 INFO - mozdevice == 0.48 01:32:52 INFO - mozfile == 1.2 01:32:52 INFO - mozhttpd == 0.7 01:32:52 INFO - mozinfo == 0.9 01:32:52 INFO - mozleak == 0.1 01:32:52 INFO - mozlog == 3.2 01:32:52 INFO - moznetwork == 0.27 01:32:52 INFO - mozprocess == 0.22 01:32:52 INFO - mozprofile == 0.28 01:32:52 INFO - mozrunner == 6.11 01:32:52 INFO - mozscreenshot == 0.1 01:32:52 INFO - mozsystemmonitor == 0.3 01:32:52 INFO - moztest == 0.7 01:32:52 INFO - mozversion == 1.4 01:32:52 INFO - psutil == 3.1.1 01:32:52 INFO - requests == 1.2.3 01:32:52 INFO - wsgiref == 0.1.2 01:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:52 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:52 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 01:32:52 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 01:32:52 INFO - Using env: {'DISPLAY': ':0', 01:32:52 INFO - 'HOME': '/home/cltbld', 01:32:52 INFO - 'LANG': 'en_US.UTF-8', 01:32:52 INFO - 'LANGUAGE': 'en_US:en', 01:32:52 INFO - 'LOGNAME': 'cltbld', 01:32:52 INFO - 'MAIL': '/var/mail/cltbld', 01:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:52 INFO - 'MOZ_NO_REMOTE': '1', 01:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:52 INFO - 'NO_EM_RESTART': '1', 01:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:52 INFO - 'PWD': '/builds/slave/test', 01:32:52 INFO - 'SHELL': '/bin/bash', 01:32:52 INFO - 'SHLVL': '1', 01:32:52 INFO - 'TERM': 'linux', 01:32:52 INFO - 'TMOUT': '86400', 01:32:52 INFO - 'USER': 'cltbld', 01:32:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:52 INFO - '_': '/tools/buildbot/bin/python'} 01:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 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)) 01:32:53 INFO - Cleaning up... 01:32:53 INFO - Return code: 0 01:32:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:32:53 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')]} 01:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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')]} 01:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:53 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 01:32:53 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 01:32:53 INFO - Using env: {'DISPLAY': ':0', 01:32:53 INFO - 'HOME': '/home/cltbld', 01:32:53 INFO - 'LANG': 'en_US.UTF-8', 01:32:53 INFO - 'LANGUAGE': 'en_US:en', 01:32:53 INFO - 'LOGNAME': 'cltbld', 01:32:53 INFO - 'MAIL': '/var/mail/cltbld', 01:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:53 INFO - 'MOZ_NO_REMOTE': '1', 01:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:53 INFO - 'NO_EM_RESTART': '1', 01:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:53 INFO - 'PWD': '/builds/slave/test', 01:32:53 INFO - 'SHELL': '/bin/bash', 01:32:53 INFO - 'SHLVL': '1', 01:32:53 INFO - 'TERM': 'linux', 01:32:53 INFO - 'TMOUT': '86400', 01:32:53 INFO - 'USER': 'cltbld', 01:32:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:53 INFO - '_': '/tools/buildbot/bin/python'} 01:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:32:53 INFO - Cleaning up... 01:32:53 INFO - Return code: 0 01:32:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:32:53 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')]} 01:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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')]} 01:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:53 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 0x7fcacdd77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, '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': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', '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 01:32:53 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 01:32:53 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 01:32:53 INFO - Using env: {'DISPLAY': ':0', 01:32:53 INFO - 'HOME': '/home/cltbld', 01:32:53 INFO - 'LANG': 'en_US.UTF-8', 01:32:53 INFO - 'LANGUAGE': 'en_US:en', 01:32:53 INFO - 'LOGNAME': 'cltbld', 01:32:53 INFO - 'MAIL': '/var/mail/cltbld', 01:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:53 INFO - 'MOZ_NO_REMOTE': '1', 01:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:53 INFO - 'NO_EM_RESTART': '1', 01:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:53 INFO - 'PWD': '/builds/slave/test', 01:32:53 INFO - 'SHELL': '/bin/bash', 01:32:53 INFO - 'SHLVL': '1', 01:32:53 INFO - 'TERM': 'linux', 01:32:53 INFO - 'TMOUT': '86400', 01:32:53 INFO - 'USER': 'cltbld', 01:32:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:53 INFO - '_': '/tools/buildbot/bin/python'} 01:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:53 INFO - Downloading/unpacking flake8 01:32:53 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 01:32:53 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 01:32:53 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 01:32:53 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 01:32:53 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 01:32:53 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 01:32:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:32:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:32:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:32:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:32:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:32:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:32:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:32:56 INFO - no previously-included directories found matching 'docs/_build' 01:32:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:32:56 INFO - Running setup.py install for pep8 01:32:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:32:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:32:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:32:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:32:56 INFO - no previously-included directories found matching 'docs/_build' 01:32:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:32:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:32:56 INFO - Cleaning up... 01:32:56 INFO - Return code: 0 01:32:56 INFO - Running post-action listener: _resource_record_post_action 01:32:56 INFO - Running post-action listener: _start_resource_monitoring 01:32:56 INFO - Starting resource monitoring. 01:32:56 INFO - ##### 01:32:56 INFO - ##### Finished create-virtualenv step (success) 01:32:56 INFO - ##### 01:32:56 INFO - ##### 01:32:56 INFO - ##### Running install step. 01:32:56 INFO - ##### 01:32:56 INFO - Running pre-action listener: _resource_record_pre_action 01:32:56 INFO - Running main action method: install 01:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:56 INFO - Reading from file tmpfile_stdout 01:32:56 INFO - Detecting whether we're running mozinstall >=1.0... 01:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:32:56 INFO - Reading from file tmpfile_stdout 01:32:56 INFO - Output received: 01:32:56 INFO - Usage: mozinstall [options] installer 01:32:56 INFO - Options: 01:32:56 INFO - -h, --help show this help message and exit 01:32:56 INFO - -d DEST, --destination=DEST 01:32:56 INFO - Directory to install application into. [default: 01:32:56 INFO - "/builds/slave/test"] 01:32:56 INFO - --app=APP Application being installed. [default: firefox] 01:32:56 INFO - mkdir: /builds/slave/test/build/application 01:32:56 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'] 01:32:56 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 01:33:13 INFO - Reading from file tmpfile_stdout 01:33:13 INFO - Output received: 01:33:13 INFO - /builds/slave/test/build/application/firefox/firefox 01:33:13 INFO - Running post-action listener: _resource_record_post_action 01:33:13 INFO - ##### 01:33:13 INFO - ##### Finished install step (success) 01:33:13 INFO - ##### 01:33:13 INFO - ##### 01:33:13 INFO - ##### Running run-tests step. 01:33:13 INFO - ##### 01:33:13 INFO - Running pre-action listener: _resource_record_pre_action 01:33:13 INFO - Running main action method: run_tests 01:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:13 INFO - Python 2.7.3 01:33:13 INFO - Return code: 0 01:33:13 INFO - grabbing minidump binary from tooltool 01:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:13 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 0x14772e0>, '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 0x13e3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:13 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 01:33:13 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 01:33:13 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 01:33:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:14 INFO - Return code: 0 01:33:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:33:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:33:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:33:14 INFO - Return code: 0 01:33:14 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:33:14 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:33:14 INFO - Using env: {'DISPLAY': ':0', 01:33:14 INFO - 'HOME': '/home/cltbld', 01:33:14 INFO - 'LANG': 'en_US.UTF-8', 01:33:14 INFO - 'LANGUAGE': 'en_US:en', 01:33:14 INFO - 'LOGNAME': 'cltbld', 01:33:14 INFO - 'MAIL': '/var/mail/cltbld', 01:33:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:14 INFO - 'MOZ_NO_REMOTE': '1', 01:33:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:14 INFO - 'NO_EM_RESTART': '1', 01:33:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:14 INFO - 'PWD': '/builds/slave/test', 01:33:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:14 INFO - 'SHELL': '/bin/bash', 01:33:14 INFO - 'SHLVL': '1', 01:33:14 INFO - 'TERM': 'linux', 01:33:14 INFO - 'TMOUT': '86400', 01:33:14 INFO - 'USER': 'cltbld', 01:33:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1466497396.327402-1235350786', 01:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:14 INFO - '_': '/tools/buildbot/bin/python'} 01:33:14 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:33:15 INFO - mozversion application_buildid: 20160621003900 01:33:15 INFO - mozversion application_changeset: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da 01:33:15 INFO - mozversion application_display_name: Nightly 01:33:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:15 INFO - mozversion application_name: Firefox 01:33:15 INFO - mozversion application_remotingname: firefox 01:33:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:33:15 INFO - mozversion application_vendor: Mozilla 01:33:15 INFO - mozversion application_version: 50.0a1 01:33:15 INFO - mozversion platform_buildid: 20160621003900 01:33:15 INFO - mozversion platform_changeset: 21a0421ca9b0e39a28b1ab1875b6ac33f06f23da 01:33:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:33:15 INFO - mozversion platform_version: 50.0a1 01:33:15 INFO - using testdate: 1466497995 01:33:15 INFO - actual date: 1466497995 01:33:15 INFO - starting webserver on 'localhost:52092' 01:33:15 INFO - SUITE-START | Running 2 tests 01:33:15 INFO - TEST-START | dromaeo_css 01:33:15 INFO - operating with platform_type : linux_ 01:33:15 INFO - Initialising browser for dromaeo_css test... 01:33:15 INFO - TEST-INFO | started process 26629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xYRsC/profile http://localhost:52092/getInfo.html) 01:33:20 INFO - PROCESS | 26629 | __metrics Screen width/height:1600/1200 01:33:20 INFO - PROCESS | 26629 | colorDepth:24 01:33:20 INFO - PROCESS | 26629 | Browser inner width/height: 1024/697 01:33:20 INFO - PROCESS | 26629 | __metrics 01:33:22 INFO - PROCESS | 26629 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:33:22 INFO - PROCESS | 26629 | console.error: PushService: 01:33:22 INFO - PROCESS | 26629 | stateChangeProcessEnqueue: Error transitioning state 01:33:22 INFO - PROCESS | 26629 | UnknownError 01:33:23 INFO - TEST-INFO | 26629: exit 0 01:33:23 INFO - Browser initialized. 01:33:23 INFO - Running cycle 1/1 for dromaeo_css test... 01:33:23 INFO - TEST-INFO | started process 26712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xYRsC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:35 INFO - PROCESS | 26712 | RSS: Main: 175169536 01:33:35 INFO - PROCESS | 26712 | 01:34:26 INFO - PROCESS | 26712 | 1466498066580 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] 01:36:39 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52092/tests/dromaeo/cssquery-ext.html) 01:36:40 INFO - PROCESS | 26712 | RSS: Main: 254836736 01:36:40 INFO - PROCESS | 26712 | 01:39:43 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-ext.html (next: http://localhost:52092/tests/dromaeo/cssquery-jquery.html) 01:39:43 INFO - PROCESS | 26712 | RSS: Main: 257466368 01:39:43 INFO - PROCESS | 26712 | 01:42:46 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52092/tests/dromaeo/cssquery-mootools.html) 01:42:46 INFO - PROCESS | 26712 | RSS: Main: 260751360 01:42:46 INFO - PROCESS | 26712 | 01:45:49 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52092/tests/dromaeo/cssquery-prototype.html) 01:45:49 INFO - PROCESS | 26712 | RSS: Main: 263032832 01:45:49 INFO - PROCESS | 26712 | 01:48:52 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52092/tests/dromaeo/cssquery-yui.html) 01:48:53 INFO - PROCESS | 26712 | RSS: Main: 237514752 01:48:53 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | Cycle 1(1): loaded http://localhost:52092/tests/dromaeo/cssquery-yui.html (next: http://localhost:52092/tests/dromaeo/cssquery-dojo.html) 01:51:56 INFO - PROCESS | 26712 | RSS: Main: 292995072 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | __start_tp_report 01:51:56 INFO - PROCESS | 26712 | _x_x_mozilla_page_load 01:51:56 INFO - PROCESS | 26712 | _x_x_mozilla_page_load_details 01:51:56 INFO - PROCESS | 26712 | |i|pagename|runs| 01:51:56 INFO - PROCESS | 26712 | |0;dojo.html;2623.645807815945;2654.4160284737363;2662.786977041837;2684.47652707722;2696.878640461179;4630.097131059445;4711.222648263041;4762.857114286573;4848.418189817226;4873.342098816659;4721.763911804404;4722.834700785474;4753.762311884409;4791.928121078186;4796.592289655384;4095.8361665533494;4247.8300867965245;4360.956390436087;4400.273954797454;4476.2390393632995;4377.190219809346;4412.867613971586;4428.97785511072;4436.955630443703;4477.059817438342;4246.893827654333;4296.914061718748;4306.181825453154;4307.913841723148;4371.78141092944;4308.18144552534;4319.200947824663;4327.156204540116;4362.149380870732;4376.124775045004;4338.826446942118;4348.456442944632;4357.869263922087;4384.0355121873135;4404.031113155101;4655.2784318430695;4757.238841785333;4824.228123500223;4829.637777166691;4865.756712164378;5190.792368305263;5223.791048358061;5233.738313084331;5240.8689782755355;5247.212918062283;5187.896242075175;5232.555232805216;5281.339832520935;5281.841544753664;5284.497972692588;4663.067386522709;4827.589654879374;4858.416989961192;4868.17241069012;4870.634702397334;5362.973185134128;5373.677579345252;5427.4301198373605;5431.538319242909;5432.619716619799;5191.428942816287;5197.29836472079;5199.038177937094;5201.375834899761;5202.947970520322;5031.245313202976;5074.644774865724;5111.7699703513435;5112.054269960069;5141;5044.8234311798915;5077.289179514871;5088.872778180576;5091.898162036812;5139.614528910347;4975.477574854661;5056.9494305057215;5060.2156665716875;5060.671056381397;5062.190049592047;4264.31770916658;4341.717788343748;4346.521882592912;4392.780360981938;4397.978010109929;3804.714646401531;3826.44516545105;3837.9424308635394;3867.9806600967377;3870.4000879863665;4324.35134729793;4435.3125265583885;4442.111577684476;4445.066536027471;4485.484169320504;5137.948620513747;5184.533391994663;5197.922031169535;5216.452272511332;5220.869478262998;4421.38100665907;4450.933236001462;4454.643628509776;4455.198064348384;4497.662675299365;4505.549445055468;4607.9078418431445;4690.249560070372;4692.272697731857;4724.858254252378;4854.19905715553;4872.3909511311085;4891.1685013548495;4897.730624815526;4934.161192597196;5177.275181474522;5191.195364718475;5191.662541934762;5197;5244.344456942882;4791.784369703302;4818.204996175592;4830.2996065571;4851.151048566558;4897.4857639947295;5059.114654935445;5092.083424983539;5097.260897169964;5099;5123.077845987609;5153.123968925217;5158.045761534128;5163.251328557413;5168.71572063525;5203.479652034917;4886.560209581155;4996.275540046746;5023.623228257969;5028.59771218309;5044.873878153076;5041.8487445376695;5053.69677819332;5066.493350664904;5067.062593420229;5117.616178786531;4987.226979818134;5000.399952005782;5051.722155281494;5054.469280725618;5060.721660308718;4922.212446008622;5035.697858128524;5047.4952504749235;5071.0872043032605;5104.081265372269;4958.603311735124;4975.0796102721115;4985.476524964826;4988.700677959334;5034.924476132787 01:51:56 INFO - PROCESS | 26712 | |1;ext.html;560.4567674915978;570.5948776368778;579.9797007104752;585.2304219950767;592.5970340168686;26983.865080674594;38625.99999999996;38948.41577376334;39007.41488877669;39380;36259.81870090646;40564;40600;40616.59383406165;40644.796776016155;7412.962935185344;7846.097698764644;7998.280154786068;8000.8799868002025;8006.799830004238;10034.247431442634;10326.58693652253;10329.793404131913;10667.83998240027;10671.19966002553;10269.22980776441;10368.585256589766;10369.688909332732;10372.688819335432;10378.896211037869;10234.948825255864;10293.176545876311;10318.484075796256;10318.968103189696;10322.845157322608;10135.493225338778;10203.89796102037;10207.744806379826;10209.387436753745;10210.2852800304;26267.474650507073;26477.205683829518;37787.81106094452;37835.810820946;37845.81077094624;3020.3053297741644;3193.8083714977174;3700.1859590889962;3707.0547010512146;3766.453864189677;28891;29503.114906552837;29532.852335738186;30205.848970755225;30716.846415768003;3047.131567503251;3205.4390481665614;3247.772655914087;3253.202965273523;3324.6176689680756;254836;255694;256187;256779.30934489198;257373;53328.466715333125;54023.45976540184;54026.18960715514;54194;54224;56608;57148.42851571514;57175.42824571701;57184.70968193495;57214;13744.725105497833;14187.78718319226;14224.857751422353;14238.28808559568;14251.287435628177;8561.14388561139;8630.741077767678;8631.870521942175;8874.86687699685;10690.51892664832;17436.5640858977;17788;17809.910950445166;18631.347902823607;18649;6884.139482564679;6972.511924165361;6990.300969902969;7016.7544135954995;7053.929460705327;835.8244768598662;856.9442986205877;878.1481962496368;909.5043201455222;949.9835176361365;27888.58167127454;27989.860050700023;28012.71987280142;28182.564357666957;28450.146495605164;960.5869476125193;997.2022382094295;1027.2141811514198;1030.5311083457009;1092.847001419802;14336.21150836714;14647.633809154644;14815.777763333559;15069.397224111131;15112.319945602474;389929;392996;396057;396201;396891;32523;32630.83684581562;32646.347073058405;32677.67322326794;32696;1047.8166320893965;1133.7845809296207;1149.6033868315417;1184.9644510664693;1188.304841667634;27375.589366159125;28833.56749648715;28884.277893052;28974.85512572508;29274.707252927197;40137.598624013386;40550.797246014765;40602;40631.39052914268;40717.796411017756;293003;295627.6967536423;295664;295722;295846;20568.177272909514;21803.78196218081;21996.89001555046;22057.448563786034;22111.557768844854;39994.600053999086;40223.79888100541;40529.797351013054;41274;41431.7928410356;34750.47874281938;35370.46944295889;35698.894627118214;35833;35881.282374352886;34428.65571344355;34822.30355392928;35354.82322588371;35405.291894161455;35469.29061418809;31080;31196.844015779774;31386.372272554876;31392.68607313989;36166.63833361738;30163;32335.149877370302;32379.838100809346;32540.51189232116;32863.507047394785;25215.243542693013;25276.368090797143;25350.239492815246;25454;25856.482870342865 01:51:56 INFO - PROCESS | 26712 | |2;jquery.html;364.50427418710547;366.7982609564739;371.4595263891038;376.63654573336726;387.59689922480624;15816.683666326666;16274.593135171612;16960;16971.915140424313;16993.915030424847;16005.439809606665;16378.344866205367;17236.224369903353;17271.74092388615;17308.48074557762;5019.849404517861;5099.4390617032095;5144.202648589456;5194.766235519411;5248.02911461379;3642.581103173129;3766.114962983697;3766.152615661482;3893.59117292683;5013.548780609744;6009.1587177795145;6132.632042077467;6134.4478996890275;6138.14066030756;6140.263168419796;5079.949200507985;5413.593980451482;6080.604760690541;6115.755369785204;6116.296625888013;3312.3706495765728;4912.926306105412;5314.5216930476445;5323.600729945231;5323.653962492425;11903.285802851857;12201.328926909106;12233.388330583435;12323.630291091282;12393.876061239362;1926.0658580588404;2009.9799002009938;2052.8973551322374;2148.9985587197393;2235.7205349331334;9088.091190880925;9202.539873006323;9206.585703643352;9528.333016688835;9554.713358599252;1728.5764987577998;1793.3992112642281;1811.8550515958823;1819.699749541324;1848.8243616856378;46410.53589464096;54029.459705402835;62445.68777156131;62738.686306568175;65140.67429662869;9203.263738900872;9792.16766574835;9832.655857044969;9900.851487227554;10083.495825208856;13529.797053044213;13604.523841665494;13624.727505449835;13647.181169129686;13662.11196272239;6645.051110066103;6653.800385988428;6703.899441508382;6785.389314961677;6889.414399775975;6039.909401358983;6106.358832322631;6128.816135515942;6329.955557333081;6363.649999249993;4211.642010429086;4287.078278170208;4305.31115021595;4398.604125628709;4410.713303635253;1803.6482885837136;1804.3865085870866;1832.5701771849385;1844;1850.1027001904065;812.8374325134997;831.584207896052;873.9344549158839;901.833160865242;902.1970446302796;16354.67290654204;16712;16889.746653800205;16979.91510042442;17350.826491735173;804.8873157757919;811.4522697179498;864.9048604653609;893.718478679214;907.2923119966437;9230.76923076915;9645.688850028753;9686.612535498642;9699.078587534173;9761.121499065119;351600;353288;378512;391374;393505;45329.54670453319;47168.528314716415;57974.42025579775;76027;77460.61269693729;788.6175205025557;820.3109388114013;858.965641374338;868.934829887761;878.8989266234337;15284.15937123469;15449.459268925533;15535.611609709847;15716.449924252596;16084.839151608803;32546.72267733656;34846.825765871006;35312;36298.637013630585;36355;44434;46607.53392466032;48663;50943.23585146152;51383.74308128435;7538.208488108669;7608.80977975555;7703.845923081395;7714.768556943301;7930.603469826601;8199.467034642728;11706.941465292619;11907.583234586747;12130.514779408724;12157.392130393622;9392.107749763762;10267;10296.227782916161;10416.166706663296;10476.790464190826;10186.74533136648;10232.948835255776;10297.845532316871;10361.533730982275;10509.579616815241;10222.6422075227;10428.217883658908;10473.266871318934;10478.423686697304;10802.567897284021;7736.1490236075115;7748.186440423674;7756.0304961879765;7807.492512986638;7958.761237162895;9625.56684949165;10387.480625968521;10454.947725261325;10506;10574.577016919546 01:51:56 INFO - PROCESS | 26712 | |3;mootools.html;1192.2190964917982;1304.9021323400748;1378.9379477923496;1447.775594782809;1690.9746353804687;7341.265873412663;7685.730999415022;7695.884561731572;7725.768226953186;7819.569923654197;7541.660625271862;7723.652435640395;7730.5361678299205;7741.071071471417;7748.6900523978975;2183;2202.6893998071123;2203.3389983005036;2210.171185805323;2210.4363387336207;2191.791779780918;2212.3473575295247;2241.3388050525054;2241.9551608967813;2242.9102835886547;2122.8301735861096;2136.5513242219076;2181.8036376726172;2209.1826024371007;2211.0381983837;2067.6071546406133;2081.2507497301112;2083.8645488043303;2084.718562993992;2088.2169186554966;2052.5176583502866;2080.9895950520304;2112.302940029802;2119.978800212009;2121.1303365620174;7540.849183016309;7571.772846814604;7645.847083058364;7648.770536883847;7797.181295963956;4527.7056991295785;4681.087187998308;4684.297355396684;4686.718796872198;4694.319323698079;2674.9465010699873;2859.7283258090447;2910.301527633374;2915.9125226243245;2920.7079292070835;941.9199368053723;952.8665986761858;958.942463452195;960.4717405426987;966.4974213409058;10328.328658637165;10483.790324193473;10496.21278404115;10508.264421490423;10513.158947284199;3946.1515774108702;4007.5992400760274;4028.335324671455;4041.0907545802547;4099.057216840143;8285.42002059862;8328.6668533258;8332.16678332162;8351;8358.45670031446;4456.086502267028;4481.305397663367;4484.506704262529;4486.147631949919;4492.797824097924;3584.766990145632;3989.222101690201;4108.137291168829;4120.320147175742;4165.97917010413;3323.7507186961075;3345.5818022747158;3396.269801992534;3427.7086447652227;3453.3956557602824;984.3995162950595;995.4375777685584;1011.4184344002228;1023.6928921323573;1029.8506716526213;835.7726658455271;848.3637272045966;861.6208868098017;889.5374405309333;893.0444424465759;5190.143626301618;5245.160774276097;5353.9196912046355;5403.83788486346;5407.459254074561;388.2874924513493;392.8389360362295;412.4967539601681;419.90342221288665;420.18064773691424;3684.09739613791;3781.111438811877;3784.356659367859;3794.6584807366917;3807.9428808567895;9097.590608422637;9378.90621093794;9454.196393306645;9522.143007129253;9541.332106752461;9433.245340372754;9446.622135114518;9452.385594936308;9503.429794212369;9511.096445837635;6771.492138089663;7213.062301900719;7237.746678866214;7252.1297444305965;7275.708971641181;5472.781088756406;5555.7499912504845;5633.521250649701;5664.85837854057;5753.050746626927;8699.565021749015;8814.427062240933;8926.955365223132;8939.463632182089;8943.329250306122;8834.602442889956;8902.154295341932;8918.777030574287;9056.547172641473;9070.591823367833;5934.792282270272;6519.315471875574;6702.463802895659;6801.353871382409;6872.759453419107;7222.386097181588;7471.589062601609;7488.251174882468;7490.812729681584;7506.43701722384;6562.081308616893;6675.299093595103;6734.9326506734305;6785.491088168308;6880.449564034965;6574.112494813139;6596.670166491752;6615;6627.834304142435;6752.189737231367;6388.8083357499345;6424.935750642434;6428.935710642833;6440.581362211441;6443.581167224115;4473.798679059385;4505.887352816206;4668.743219122981;4706.1764191267075;4712.7407992559365;4475.776211189363;4734.147853386424;4770.189067858541;4783.617310615073;4814.879628009187 01:51:56 INFO - PROCESS | 26712 | |4;prototype.html;288.9364339845235;294.1587061005524;299.20262500436337;305.523383521706;305.68819803800125;4680.812767489305;4825.758712064396;4843.280635374435;4844.903101937964;4848.539388758067;4546.3180522921575;4714.292856071591;4759.976200119003;4765.928511072337;4780.784864681089;3712.9628703712956;3751.2872554214614;3756.924861502768;3759.8308076136504;3806.3148633246005;3610.9277814443694;3682.6133256008134;3780.6786423154067;3781.45168950502;3792.412176112707;3734.3091528067257;3744.8876533704033;3758.6696248326075;3764.7552909060823;3773.8301776420126;3697.334479793636;3715.4055351143957;3717.5538935327663;3721.776693398405;3738.719596030309;3284.1625385526777;3294.275259442919;3301.290222602128;3307.851146698404;3326.617438994498;4605.240135377659;4639.443266807971;4707.199776038082;4713.198756211452;4721.291806229059;4283.528811830696;4320;4322.697411181219;4322.697411181219;4332.1985432695055;5034.899302013976;5054.342935418409;5060.873478163038;5072.239164125411;5090.211017292326;3352.6312105668358;3537.2748586539697;3556.928861422757;3642.453631955201;3645.2891686121216;5220.425753167148;5234.293370394986;5241.554467870235;5242.6330156889035;5260.8684782880355;3523.9295214095573;3568.5360903082433;3569.714422846166;3575.8212089395424;3578.481120237603;3606.611454589949;3619.4027985382645;3627.1657518770303;3647.5805282392867;3657.5428071491065;4062.390641403813;4270.679699022586;4274.26447073873;4279.251131052053;4287.121140166259;5043.420006699276;5050.520200580939;5085.186370180753;5108.697282193091;5120.411152717411;1216.4525963316544;1242.186367929008;1261.832804655708;1266.6326765238161;1283.4288741509938;803.8753993130957;816.5386556595623;826.8057006603443;833.8999320081629;835.4026870787416;4034.45534852797;4041.9288888444585;4052.0882801369457;4056.553779084298;4058.1680755445063;4653.930191047137;4661.790219440133;4663.720176789404;4664.930026049612;4690.835820746258;4027.657649099801;4061;4092.529359123679;4096.672266218696;4111.568285330057;2375.4298968247494;2532.898684052654;2536.9492610147695;2537.2134638262196;2537.3529749913655;4431.33529970507;4433.024734558392;4441.578050085237;4457.598816106566;4510.376264544761;4713.505081966413;4717.38185307151;4717.976410117927;4730.172219861511;4765.164726987437;4387.517373088957;4412.367424053121;4620.7227566345455;5074.771635276347;5080.390353157644;5317.361916570037;5355.30381050461;5362.168863826113;5362.892742145214;5387;5229.084910140787;5242.18746094356;5242.895142097213;5248.6588371755715;5256.342957130359;4885.340479035427;4913.7713343533105;4961;5032.521910418504;5033.597312214941;3718.200586873835;3724.9011541595837;3726.124360775161;3769.2838360711376;3773;5119.923201151912;5343.465653434625;5347.475969348717;5355.384130824849;5363;5021.648484606042;5160.48395160496;5173.22401639757;5208.192730126836;5208.4270730220405;5175.9741201293755;5188.377394712658;5191.480851914778;5195;5199.792008319776;4845.2732090186755;5005.899882002413;5099.949000509948;5101.795928162832;5119.616028797929;5140.399342588437;5180.7409629519125;5182.740862956762;5191.402988656353;5192.350956130484;5072.239164125263;5075.390953085654;5086.160783470834;5086.898262034812;5098.311727916832 01:51:56 INFO - PROCESS | 26712 | |5;yui.html;605.2938403909603;620.2216218645597;653.1182903080839;658.7359633018394;710.9466789990748;12281.938590307047;12612.62162135135;12914.870851291507;13413.061085724003;13414.530491432803;12840.101192916476;12845.67885802853;12982;12987.870121298783;12998.155119917199;621.6270237857273;771.5833449937028;773.331068625639;795.8965334506506;799.400449662753;770.7495064104188;771.4599780153886;774.4230548241568;774.8798936164903;774.8992630957968;814.1939479914871;814.4705941138249;814.771863878115;815.2499700275731;815.9306458950966;641.7272659119878;771.7646117934056;772.6677528662673;793.6349279331514;793.7340990768099;591.1635036423455;591.9023361145406;591.9496842768369;592.236015539953;592.4194289596177;12842.165259258118;12862.292573908431;12866.678333041655;12877.356132193352;12904.354782260849;10909.672709818718;11687.357195354252;11751.941240293829;12084.214526055779;12234.81647775284;11143.498542565603;11187;11547.480363383667;11623.418829058597;11646.59236926712;4108.096218831853;4133.028738246509;4186.518550366716;4255.425517555122;4303.956960430387;53837.73081134569;55179.44820551783;55307.170392444146;55943.72028139874;55975;9875.60497580103;9943.45876389161;9973.351732137533;10013.799724005625;10137.898621013843;18038.098095095193;18043.729344059848;18070.283323084284;18088.457346279632;18094.457166285032;6673.599584024877;6681.966590167018;6689.063531105649;6711.865762684719;6874.690638921261;3632.5277713897553;3673.228621989412;3675.448682697563;3691.5754688210664;3762.360398732222;2689.5562232231464;2780.0686769931895;2780.7358300961378;2796.384795345021;2798;469.77216050215617;480.06627110270887;490.85274417674555;494.5376073371409;494.97772600233077;436.943197384338;484.4041828550902;533.4931814775979;588.6879953624585;593.2376895689019;7502.174760776419;7633.5419874807685;7637.770866874002;7680.500767450098;7794.766157015299;520.0249532127261;531.8590573498026;572.9800954301351;605.6487237402296;607.8814631146972;3506.631803660579;3718.5723641781;3776.6789822864816;3777.9219942830687;3782.3759079751535;85881.57059214664;86971.56514217389;88092;88700.5564972171;88718;77045;78727.21272787199;78926.60536697395;79113.60443197747;79673.20326796657;68910;69933;71057;71430.64284678648;71512;7252.673629686782;7427.925720742724;7580.431467639839;7597.164311925573;7626.96186519086;40076;40636.390454142624;42117;42133.57866421419;42399.152016960106;38932;48284;49317.01365972589;52256.21615675692;53188.936221274584;9355.204807591432;9444.102810233016;9568.56941437623;9709.029097090235;9903.306768526134;10665.200109991936;10769.368723098758;10969.396683182182;11058.447077646246;11279.605213817476;9519;9583.712488625353;9660.903390966001;9848.06443387877;10348.482575871327;9268.582913768762;9269.582868771056;9285.4892980884;9311.674091406769;9352.205062569758;9417.293702972442;9763.609455621696;9846;10040.435645345797;10248.795024099327;7857.607119643881;7930.444868859356;8420.5789710513;8560.299714557386;8677.739667809976;8097.2307630774985;8122.75631731049;8558;8592.527410992456;8682 01:51:56 INFO - PROCESS | 26712 | __end_tp_report 01:51:56 INFO - PROCESS | 26712 | __start_cc_report 01:51:56 INFO - PROCESS | 26712 | _x_x_mozilla_cycle_collect,1073 01:51:56 INFO - PROCESS | 26712 | __end_cc_report 01:51:56 INFO - PROCESS | 26712 | __startTimestamp1466499116262__endTimestamp 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | ------- Summary: start ------- 01:51:56 INFO - PROCESS | 26712 | Number of tests: 6 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#0] dojo.html Cycles:165 Average:4759.89 Median:4891.17 stddev:522.47 (10.7%) stddev-sans-first:496.47 01:51:56 INFO - PROCESS | 26712 | Values: 2623.6 2654.4 2662.8 2684.5 2696.9 4630.1 4711.2 4762.9 4848.4 4873.3 4721.8 4722.8 4753.8 4791.9 4796.6 4095.8 4247.8 4361.0 4400.3 4476.2 4377.2 4412.9 4429.0 4437.0 4477.1 4246.9 4296.9 4306.2 4307.9 4371.8 4308.2 4319.2 4327.2 4362.1 4376.1 4338.8 4348.5 4357.9 4384.0 4404.0 4655.3 4757.2 4824.2 4829.6 4865.8 5190.8 5223.8 5233.7 5240.9 5247.2 5187.9 5232.6 5281.3 5281.8 5284.5 4663.1 4827.6 4858.4 4868.2 4870.6 5363.0 5373.7 5427.4 5431.5 5432.6 5191.4 5197.3 5199.0 5201.4 5202.9 5031.2 5074.6 5111.8 5112.1 5141.0 5044.8 5077.3 5088.9 5091.9 5139.6 4975.5 5056.9 5060.2 5060.7 5062.2 4264.3 4341.7 4346.5 4392.8 4398.0 3804.7 3826.4 3837.9 3868.0 3870.4 4324.4 4435.3 4442.1 4445.1 4485.5 5137.9 5184.5 5197.9 5216.5 5220.9 4421.4 4450.9 4454.6 4455.2 4497.7 4505.5 4607.9 4690.2 4692.3 4724.9 4854.2 4872.4 4891.2 4897.7 4934.2 5177.3 5191.2 5191.7 5197.0 5244.3 4791.8 4818.2 4830.3 4851.2 4897.5 5059.1 5092.1 5097.3 5099.0 5123.1 5153.1 5158.0 5163.3 5168.7 5203.5 4886.6 4996.3 5023.6 5028.6 5044.9 5041.8 5053.7 5066.5 5067.1 5117.6 4987.2 5000.4 5051.7 5054.5 5060.7 4922.2 5035.7 5047.5 5071.1 5104.1 4958.6 4975.1 4985.5 4988.7 5034.9 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#1] ext.html Cycles:180 Average:46424.04 Median:17770.29 stddev:84384.33 (474.9%) stddev-sans-first:84550.79 01:51:56 INFO - PROCESS | 26712 | Values: 560.5 570.6 580.0 585.2 592.6 26983.9 38626.0 38948.4 39007.4 39380.0 36259.8 40564.0 40600.0 40616.6 40644.8 7413.0 7846.1 7998.3 8000.9 8006.8 10034.2 10326.6 10329.8 10667.8 10671.2 10269.2 10368.6 10369.7 10372.7 10378.9 10234.9 10293.2 10318.5 10319.0 10322.8 10135.5 10203.9 10207.7 10209.4 10210.3 26267.5 26477.2 37787.8 37835.8 37845.8 3020.3 3193.8 3700.2 3707.1 3766.5 28891.0 29503.1 29532.9 30205.8 30716.8 3047.1 3205.4 3247.8 3253.2 3324.6 254836.0 255694.0 256187.0 256779.3 257373.0 53328.5 54023.5 54026.2 54194.0 54224.0 56608.0 57148.4 57175.4 57184.7 57214.0 13744.7 14187.8 14224.9 14238.3 14251.3 8561.1 8630.7 8631.9 8874.9 10690.5 17436.6 17788.0 17809.9 18631.3 18649.0 6884.1 6972.5 6990.3 7016.8 7053.9 835.8 856.9 878.1 909.5 950.0 27888.6 27989.9 28012.7 28182.6 28450.1 960.6 997.2 1027.2 1030.5 1092.8 14336.2 14647.6 14815.8 15069.4 15112.3 389929.0 392996.0 396057.0 396201.0 396891.0 32523.0 32630.8 32646.3 32677.7 32696.0 1047.8 1133.8 1149.6 1185.0 1188.3 27375.6 28833.6 28884.3 28974.9 29274.7 40137.6 40550.8 40602.0 40631.4 40717.8 293003.0 295627.7 295664.0 295722.0 295846.0 20568.2 21803.8 21996.9 22057.4 22111.6 39994.6 40223.8 40529.8 41274.0 41431.8 34750.5 35370.5 35698.9 35833.0 35881.3 34428.7 34822.3 35354.8 35405.3 35469.3 31080.0 31196.8 31386.4 31392.7 36166.6 30163.0 32335.1 32379.8 32540.5 32863.5 25215.2 25276.4 25350.2 25454.0 25856.5 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#2] jquery.html Cycles:180 Average:22673.88 Median:4351.96 stddev:61398.71 (1410.8%) stddev-sans-first:61548.10 01:51:56 INFO - PROCESS | 26712 | Values: 364.5 366.8 371.5 376.6 387.6 15816.7 16274.6 16960.0 16971.9 16993.9 16005.4 16378.3 17236.2 17271.7 17308.5 5019.8 5099.4 5144.2 5194.8 5248.0 3642.6 3766.1 3766.2 3893.6 5013.5 6009.2 6132.6 6134.4 6138.1 6140.3 5079.9 5413.6 6080.6 6115.8 6116.3 3312.4 4912.9 5314.5 5323.6 5323.7 11903.3 12201.3 12233.4 12323.6 12393.9 1926.1 2010.0 2052.9 2149.0 2235.7 9088.1 9202.5 9206.6 9528.3 9554.7 1728.6 1793.4 1811.9 1819.7 1848.8 46410.5 54029.5 62445.7 62738.7 65140.7 9203.3 9792.2 9832.7 9900.9 10083.5 13529.8 13604.5 13624.7 13647.2 13662.1 6645.1 6653.8 6703.9 6785.4 6889.4 6039.9 6106.4 6128.8 6330.0 6363.6 4211.6 4287.1 4305.3 4398.6 4410.7 1803.6 1804.4 1832.6 1844.0 1850.1 812.8 831.6 873.9 901.8 902.2 16354.7 16712.0 16889.7 16979.9 17350.8 804.9 811.5 864.9 893.7 907.3 9230.8 9645.7 9686.6 9699.1 9761.1 351600.0 353288.0 378512.0 391374.0 393505.0 45329.5 47168.5 57974.4 76027.0 77460.6 788.6 820.3 859.0 868.9 878.9 15284.2 15449.5 15535.6 15716.4 16084.8 32546.7 34846.8 35312.0 36298.6 36355.0 44434.0 46607.5 48663.0 50943.2 51383.7 7538.2 7608.8 7703.8 7714.8 7930.6 8199.5 11706.9 11907.6 12130.5 12157.4 9392.1 10267.0 10296.2 10416.2 10476.8 10186.7 10232.9 10297.8 10361.5 10509.6 10222.6 10428.2 10473.3 10478.4 10802.6 7736.1 7748.2 7756.0 7807.5 7958.8 9625.6 10387.5 10454.9 10506.0 10574.6 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#3] mootools.html Cycles:180 Average:5063.06 Median:5378.88 stddev:2840.14 (52.8%) stddev-sans-first:2833.21 01:51:56 INFO - PROCESS | 26712 | Values: 1192.2 1304.9 1378.9 1447.8 1691.0 7341.3 7685.7 7695.9 7725.8 7819.6 7541.7 7723.7 7730.5 7741.1 7748.7 2183.0 2202.7 2203.3 2210.2 2210.4 2191.8 2212.3 2241.3 2242.0 2242.9 2122.8 2136.6 2181.8 2209.2 2211.0 2067.6 2081.3 2083.9 2084.7 2088.2 2052.5 2081.0 2112.3 2120.0 2121.1 7540.8 7571.8 7645.8 7648.8 7797.2 4527.7 4681.1 4684.3 4686.7 4694.3 2674.9 2859.7 2910.3 2915.9 2920.7 941.9 952.9 958.9 960.5 966.5 10328.3 10483.8 10496.2 10508.3 10513.2 3946.2 4007.6 4028.3 4041.1 4099.1 8285.4 8328.7 8332.2 8351.0 8358.5 4456.1 4481.3 4484.5 4486.1 4492.8 3584.8 3989.2 4108.1 4120.3 4166.0 3323.8 3345.6 3396.3 3427.7 3453.4 984.4 995.4 1011.4 1023.7 1029.9 835.8 848.4 861.6 889.5 893.0 5190.1 5245.2 5353.9 5403.8 5407.5 388.3 392.8 412.5 419.9 420.2 3684.1 3781.1 3784.4 3794.7 3807.9 9097.6 9378.9 9454.2 9522.1 9541.3 9433.2 9446.6 9452.4 9503.4 9511.1 6771.5 7213.1 7237.7 7252.1 7275.7 5472.8 5555.7 5633.5 5664.9 5753.1 8699.6 8814.4 8927.0 8939.5 8943.3 8834.6 8902.2 8918.8 9056.5 9070.6 5934.8 6519.3 6702.5 6801.4 6872.8 7222.4 7471.6 7488.3 7490.8 7506.4 6562.1 6675.3 6734.9 6785.5 6880.4 6574.1 6596.7 6615.0 6627.8 6752.2 6388.8 6424.9 6428.9 6440.6 6443.6 4473.8 4505.9 4668.7 4706.2 4712.7 4475.8 4734.1 4770.2 4783.6 4814.9 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#4] prototype.html Cycles:180 Average:4137.96 Median:4646.69 stddev:1229.68 (26.5%) stddev-sans-first:1198.71 01:51:56 INFO - PROCESS | 26712 | Values: 288.9 294.2 299.2 305.5 305.7 4680.8 4825.8 4843.3 4844.9 4848.5 4546.3 4714.3 4760.0 4765.9 4780.8 3713.0 3751.3 3756.9 3759.8 3806.3 3610.9 3682.6 3780.7 3781.5 3792.4 3734.3 3744.9 3758.7 3764.8 3773.8 3697.3 3715.4 3717.6 3721.8 3738.7 3284.2 3294.3 3301.3 3307.9 3326.6 4605.2 4639.4 4707.2 4713.2 4721.3 4283.5 4320.0 4322.7 4322.7 4332.2 5034.9 5054.3 5060.9 5072.2 5090.2 3352.6 3537.3 3556.9 3642.5 3645.3 5220.4 5234.3 5241.6 5242.6 5260.9 3523.9 3568.5 3569.7 3575.8 3578.5 3606.6 3619.4 3627.2 3647.6 3657.5 4062.4 4270.7 4274.3 4279.3 4287.1 5043.4 5050.5 5085.2 5108.7 5120.4 1216.5 1242.2 1261.8 1266.6 1283.4 803.9 816.5 826.8 833.9 835.4 4034.5 4041.9 4052.1 4056.6 4058.2 4653.9 4661.8 4663.7 4664.9 4690.8 4027.7 4061.0 4092.5 4096.7 4111.6 2375.4 2532.9 2536.9 2537.2 2537.4 4431.3 4433.0 4441.6 4457.6 4510.4 4713.5 4717.4 4718.0 4730.2 4765.2 4387.5 4412.4 4620.7 5074.8 5080.4 5317.4 5355.3 5362.2 5362.9 5387.0 5229.1 5242.2 5242.9 5248.7 5256.3 4885.3 4913.8 4961.0 5032.5 5033.6 3718.2 3724.9 3726.1 3769.3 3773.0 5119.9 5343.5 5347.5 5355.4 5363.0 5021.6 5160.5 5173.2 5208.2 5208.4 5176.0 5188.4 5191.5 5195.0 5199.8 4845.3 5005.9 5099.9 5101.8 5119.6 5140.4 5180.7 5182.7 5191.4 5192.4 5072.2 5075.4 5086.2 5086.9 5098.3 01:51:56 INFO - PROCESS | 26712 | 01:51:56 INFO - PROCESS | 26712 | [#5] yui.html Cycles:180 Average:16121.02 Median:592.33 stddev:22849.67 (3857.6%) stddev-sans-first:22884.07 01:51:56 INFO - PROCESS | 26712 | Values: 605.3 620.2 653.1 658.7 710.9 12281.9 12612.6 12914.9 13413.1 13414.5 12840.1 12845.7 12982.0 12987.9 12998.2 621.6 771.6 773.3 795.9 799.4 770.7 771.5 774.4 774.9 774.9 814.2 814.5 814.8 815.2 815.9 641.7 771.8 772.7 793.6 793.7 591.2 591.9 591.9 592.2 592.4 12842.2 12862.3 12866.7 12877.4 12904.4 10909.7 11687.4 11751.9 12084.2 12234.8 11143.5 11187.0 11547.5 11623.4 11646.6 4108.1 4133.0 4186.5 4255.4 4304.0 53837.7 55179.4 55307.2 55943.7 55975.0 9875.6 9943.5 9973.4 10013.8 10137.9 18038.1 18043.7 18070.3 18088.5 18094.5 6673.6 6682.0 6689.1 6711.9 6874.7 3632.5 3673.2 3675.4 3691.6 3762.4 2689.6 2780.1 2780.7 2796.4 2798.0 469.8 480.1 490.9 494.5 495.0 436.9 484.4 533.5 588.7 593.2 7502.2 7633.5 7637.8 7680.5 7794.8 520.0 531.9 573.0 605.6 607.9 3506.6 3718.6 3776.7 3777.9 3782.4 85881.6 86971.6 88092.0 88700.6 88718.0 77045.0 78727.2 78926.6 79113.6 79673.2 68910.0 69933.0 71057.0 71430.6 71512.0 7252.7 7427.9 7580.4 7597.2 7627.0 40076.0 40636.4 42117.0 42133.6 42399.2 38932.0 48284.0 49317.0 52256.2 53188.9 9355.2 9444.1 9568.6 9709.0 9903.3 10665.2 10769.4 10969.4 11058.4 11279.6 9519.0 9583.7 9660.9 9848.1 10348.5 9268.6 9269.6 9285.5 9311.7 9352.2 9417.3 9763.6 9846.0 10040.4 10248.8 7857.6 7930.4 8420.6 8560.3 8677.7 8097.2 8122.8 8558.0 8592.5 8682.0 01:51:56 INFO - PROCESS | 26712 | -------- Summary: end -------- 01:51:56 INFO - PROCESS | 26712 | 01:51:57 INFO - TEST-INFO | 26712: exit 0 01:51:57 INFO - TEST-OK | dromaeo_css | took 1121947ms 01:51:57 INFO - TEST-START | kraken 01:51:57 INFO - operating with platform_type : linux_ 01:51:57 INFO - Initialising browser for kraken test... 01:51:57 INFO - TEST-INFO | started process 26892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvK85V/profile http://localhost:52092/getInfo.html) 01:52:01 INFO - PROCESS | 26892 | __metrics Screen width/height:1600/1200 01:52:01 INFO - PROCESS | 26892 | colorDepth:24 01:52:01 INFO - PROCESS | 26892 | Browser inner width/height: 1024/697 01:52:01 INFO - PROCESS | 26892 | __metrics 01:52:03 INFO - PROCESS | 26892 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:52:03 INFO - PROCESS | 26892 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:52:04 INFO - TEST-INFO | 26892: exit 0 01:52:04 INFO - Browser initialized. 01:52:04 INFO - Running cycle 1/1 for kraken test... 01:52:04 INFO - TEST-INFO | started process 26975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgvK85V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:52:16 INFO - PROCESS | 26975 | RSS: Main: 175185920 01:52:16 INFO - PROCESS | 26975 | 01:52:19 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection) 01:52:20 INFO - PROCESS | 26975 | RSS: Main: 232964096 01:52:20 INFO - PROCESS | 26975 | 01:52:22 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-dft) 01:52:23 INFO - PROCESS | 26975 | RSS: Main: 220405760 01:52:23 INFO - PROCESS | 26975 | 01:52:26 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-fft) 01:52:27 INFO - PROCESS | 26975 | RSS: Main: 289157120 01:52:27 INFO - PROCESS | 26975 | 01:52:29 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator) 01:52:30 INFO - PROCESS | 26975 | RSS: Main: 198848512 01:52:30 INFO - PROCESS | 26975 | 01:52:32 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:52:33 INFO - PROCESS | 26975 | RSS: Main: 202747904 01:52:33 INFO - PROCESS | 26975 | 01:52:36 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom) 01:52:36 INFO - PROCESS | 26975 | RSS: Main: 239251456 01:52:36 INFO - PROCESS | 26975 | 01:52:40 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate) 01:52:41 INFO - PROCESS | 26975 | RSS: Main: 234766336 01:52:41 INFO - PROCESS | 26975 | 01:52:43 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial) 01:52:44 INFO - PROCESS | 26975 | RSS: Main: 237486080 01:52:44 INFO - PROCESS | 26975 | 01:52:46 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:46 INFO - PROCESS | 26975 | RSS: Main: 225402880 01:52:46 INFO - PROCESS | 26975 | 01:52:48 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:49 INFO - PROCESS | 26975 | RSS: Main: 231538688 01:52:49 INFO - PROCESS | 26975 | 01:52:51 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:52 INFO - PROCESS | 26975 | RSS: Main: 238440448 01:52:52 INFO - PROCESS | 26975 | 01:52:55 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:55 INFO - PROCESS | 26975 | RSS: Main: 240766976 01:52:55 INFO - PROCESS | 26975 | 01:52:58 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:59 INFO - PROCESS | 26975 | RSS: Main: 240754688 01:52:59 INFO - PROCESS | 26975 | 01:53:00 INFO - PROCESS | 26975 | Cycle 1(1): loaded http://localhost:52092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52092/tests/kraken/driver.html?testName=ai-astar) 01:53:01 INFO - PROCESS | 26975 | RSS: Main: 283852800 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | __start_tp_report 01:53:01 INFO - PROCESS | 26975 | _x_x_mozilla_page_load 01:53:01 INFO - PROCESS | 26975 | _x_x_mozilla_page_load_details 01:53:01 INFO - PROCESS | 26975 | |i|pagename|runs| 01:53:01 INFO - PROCESS | 26975 | |0;ai-astar;113;107;114;114;113;113;113;114;113;113 01:53:01 INFO - PROCESS | 26975 | |1;audio-beat-detection;164;130;131;181;131;133;164;141;192;136 01:53:01 INFO - PROCESS | 26975 | |2;audio-dft;163;161;161;159;164;162;160;162;161;162 01:53:01 INFO - PROCESS | 26975 | |3;audio-fft;74;77;75;114;76;77;77;77;99;75 01:53:01 INFO - PROCESS | 26975 | |4;audio-oscillator;87;86;116;86;86;87;117;87;87;131 01:53:01 INFO - PROCESS | 26975 | |5;imaging-gaussian-blur;118;118;117;118;118;117;117;118;119;118 01:53:01 INFO - PROCESS | 26975 | |6;imaging-darkroom;147;147;146;147;146;148;147;146;146;146 01:53:01 INFO - PROCESS | 26975 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 01:53:01 INFO - PROCESS | 26975 | |8;json-parse-financial;64;63;65;63;65;65;64;64;64;64 01:53:01 INFO - PROCESS | 26975 | |9;json-stringify-tinderbox;66;67;65;65;66;66;66;65;66;65 01:53:01 INFO - PROCESS | 26975 | |10;stanford-crypto-aes;84;85;84;90;84;85;87;85;116;84 01:53:01 INFO - PROCESS | 26975 | |11;stanford-crypto-ccm;135;135;143;141;133;133;128;129;142;132 01:53:01 INFO - PROCESS | 26975 | |12;stanford-crypto-pbkdf2;169;173;166;167;166;166;171;168;175;171 01:53:01 INFO - PROCESS | 26975 | |13;stanford-crypto-sha256-iterative;67;71;67;66;67;72;67;66;66;66 01:53:01 INFO - PROCESS | 26975 | __end_tp_report 01:53:01 INFO - PROCESS | 26975 | __start_cc_report 01:53:01 INFO - PROCESS | 26975 | _x_x_mozilla_cycle_collect,1961 01:53:01 INFO - PROCESS | 26975 | __end_cc_report 01:53:01 INFO - PROCESS | 26975 | __startTimestamp1466499181211__endTimestamp 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | ------- Summary: start ------- 01:53:01 INFO - PROCESS | 26975 | Number of tests: 14 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:2.06 (1.8%) stddev-sans-first:2.18 01:53:01 INFO - PROCESS | 26975 | Values: 113.0 107.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:152.50 stddev:23.10 (15.2%) stddev-sans-first:23.97 01:53:01 INFO - PROCESS | 26975 | Values: 164.0 130.0 131.0 181.0 131.0 133.0 164.0 141.0 192.0 136.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.41 01:53:01 INFO - PROCESS | 26975 | Values: 163.0 161.0 161.0 159.0 164.0 162.0 160.0 162.0 161.0 162.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:13.38 (17.4%) stddev-sans-first:13.87 01:53:01 INFO - PROCESS | 26975 | Values: 74.0 77.0 75.0 114.0 76.0 77.0 77.0 77.0 99.0 75.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.50 stddev:17.26 (19.9%) stddev-sans-first:17.92 01:53:01 INFO - PROCESS | 26975 | Values: 87.0 86.0 116.0 86.0 86.0 87.0 117.0 87.0 87.0 131.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:53:01 INFO - PROCESS | 26975 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 119.0 118.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:53:01 INFO - PROCESS | 26975 | Values: 147.0 147.0 146.0 147.0 146.0 148.0 147.0 146.0 146.0 146.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:53:01 INFO - PROCESS | 26975 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 01:53:01 INFO - PROCESS | 26975 | Values: 64.0 63.0 65.0 63.0 65.0 65.0 64.0 64.0 64.0 64.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:53:01 INFO - PROCESS | 26975 | Values: 66.0 67.0 65.0 65.0 66.0 66.0 66.0 65.0 66.0 65.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.00 stddev:9.88 (11.6%) stddev-sans-first:10.35 01:53:01 INFO - PROCESS | 26975 | Values: 84.0 85.0 84.0 90.0 84.0 85.0 87.0 85.0 116.0 84.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:135.00 stddev:5.28 (3.9%) stddev-sans-first:5.60 01:53:01 INFO - PROCESS | 26975 | Values: 135.0 135.0 143.0 141.0 133.0 133.0 128.0 129.0 142.0 132.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:170.00 stddev:3.19 (1.9%) stddev-sans-first:3.38 01:53:01 INFO - PROCESS | 26975 | Values: 169.0 173.0 166.0 167.0 166.0 166.0 171.0 168.0 175.0 171.0 01:53:01 INFO - PROCESS | 26975 | 01:53:01 INFO - PROCESS | 26975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.17 (3.2%) stddev-sans-first:2.30 01:53:01 INFO - PROCESS | 26975 | Values: 67.0 71.0 67.0 66.0 67.0 72.0 67.0 66.0 66.0 66.0 01:53:01 INFO - PROCESS | 26975 | -------- Summary: end -------- 01:53:01 INFO - PROCESS | 26975 | 01:53:02 INFO - TEST-INFO | 26975: exit 0 01:53:02 INFO - TEST-OK | kraken | took 65305ms 01:53:02 INFO - SUITE-END | took 1187s 01:53:02 INFO - Completed test suite (00:19:47) 01:53:02 INFO - javascript benchmark 01:53:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.645807815945, 2654.4160284737363, 2662.786977041837, 2684.47652707722, 2696.878640461179, 4630.097131059445, 4711.222648263041, 4762.857114286573, 4848.418189817226, 4873.342098816659, 4721.763911804404, 4722.834700785474, 4753.762311884409, 4791.928121078186, 4796.592289655384, 4095.8361665533494, 4247.8300867965245, 4360.956390436087, 4400.273954797454, 4476.2390393632995, 4377.190219809346, 4412.867613971586, 4428.97785511072, 4436.955630443703, 4477.059817438342, 4246.893827654333, 4296.914061718748, 4306.181825453154, 4307.913841723148, 4371.78141092944, 4308.18144552534, 4319.200947824663, 4327.156204540116, 4362.149380870732, 4376.124775045004, 4338.826446942118, 4348.456442944632, 4357.869263922087, 4384.0355121873135, 4404.031113155101, 4655.2784318430695, 4757.238841785333, 4824.228123500223, 4829.637777166691, 4865.756712164378, 5190.792368305263, 5223.791048358061, 5233.738313084331, 5240.8689782755355, 5247.212918062283, 5187.896242075175, 5232.555232805216, 5281.339832520935, 5281.841544753664, 5284.497972692588, 4663.067386522709, 4827.589654879374, 4858.416989961192, 4868.17241069012, 4870.634702397334, 5362.973185134128, 5373.677579345252, 5427.4301198373605, 5431.538319242909, 5432.619716619799, 5191.428942816287, 5197.29836472079, 5199.038177937094, 5201.375834899761, 5202.947970520322, 5031.245313202976, 5074.644774865724, 5111.7699703513435, 5112.054269960069, 5141.0, 5044.8234311798915, 5077.289179514871, 5088.872778180576, 5091.898162036812, 5139.614528910347, 4975.477574854661, 5056.9494305057215, 5060.2156665716875, 5060.671056381397, 5062.190049592047, 4264.31770916658, 4341.717788343748, 4346.521882592912, 4392.780360981938, 4397.978010109929, 3804.714646401531, 3826.44516545105, 3837.9424308635394, 3867.9806600967377, 3870.4000879863665, 4324.35134729793, 4435.3125265583885, 4442.111577684476, 4445.066536027471, 4485.484169320504, 5137.948620513747, 5184.533391994663, 5197.922031169535, 5216.452272511332, 5220.869478262998, 4421.38100665907, 4450.933236001462, 4454.643628509776, 4455.198064348384, 4497.662675299365, 4505.549445055468, 4607.9078418431445, 4690.249560070372, 4692.272697731857, 4724.858254252378, 4854.19905715553, 4872.3909511311085, 4891.1685013548495, 4897.730624815526, 4934.161192597196, 5177.275181474522, 5191.195364718475, 5191.662541934762, 5197.0, 5244.344456942882, 4791.784369703302, 4818.204996175592, 4830.2996065571, 4851.151048566558, 4897.4857639947295, 5059.114654935445, 5092.083424983539, 5097.260897169964, 5099.0, 5123.077845987609, 5153.123968925217, 5158.045761534128, 5163.251328557413, 5168.71572063525, 5203.479652034917, 4886.560209581155, 4996.275540046746, 5023.623228257969, 5028.59771218309, 5044.873878153076, 5041.8487445376695, 5053.69677819332, 5066.493350664904, 5067.062593420229, 5117.616178786531, 4987.226979818134, 5000.399952005782, 5051.722155281494, 5054.469280725618, 5060.721660308718, 4922.212446008622, 5035.697858128524, 5047.4952504749235, 5071.0872043032605, 5104.081265372269, 4958.603311735124, 4975.0796102721115, 4985.476524964826, 4988.700677959334, 5034.924476132787], "value": 4725.342761236931, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4567674915978, 570.5948776368778, 579.9797007104752, 585.2304219950767, 592.5970340168686, 26983.865080674594, 38625.99999999996, 38948.41577376334, 39007.41488877669, 39380.0, 36259.81870090646, 40564.0, 40600.0, 40616.59383406165, 40644.796776016155, 7412.962935185344, 7846.097698764644, 7998.280154786068, 8000.8799868002025, 8006.799830004238, 10034.247431442634, 10326.58693652253, 10329.793404131913, 10667.83998240027, 10671.19966002553, 10269.22980776441, 10368.585256589766, 10369.688909332732, 10372.688819335432, 10378.896211037869, 10234.948825255864, 10293.176545876311, 10318.484075796256, 10318.968103189696, 10322.845157322608, 10135.493225338778, 10203.89796102037, 10207.744806379826, 10209.387436753745, 10210.2852800304, 26267.474650507073, 26477.205683829518, 37787.81106094452, 37835.810820946, 37845.81077094624, 3020.3053297741644, 3193.8083714977174, 3700.1859590889962, 3707.0547010512146, 3766.453864189677, 28891.0, 29503.114906552837, 29532.852335738186, 30205.848970755225, 30716.846415768003, 3047.131567503251, 3205.4390481665614, 3247.772655914087, 3253.202965273523, 3324.6176689680756, 254836.0, 255694.0, 256187.0, 256779.30934489198, 257373.0, 53328.466715333125, 54023.45976540184, 54026.18960715514, 54194.0, 54224.0, 56608.0, 57148.42851571514, 57175.42824571701, 57184.70968193495, 57214.0, 13744.725105497833, 14187.78718319226, 14224.857751422353, 14238.28808559568, 14251.287435628177, 8561.14388561139, 8630.741077767678, 8631.870521942175, 8874.86687699685, 10690.51892664832, 17436.5640858977, 17788.0, 17809.910950445166, 18631.347902823607, 18649.0, 6884.139482564679, 6972.511924165361, 6990.300969902969, 7016.7544135954995, 7053.929460705327, 835.8244768598662, 856.9442986205877, 878.1481962496368, 909.5043201455222, 949.9835176361365, 27888.58167127454, 27989.860050700023, 28012.71987280142, 28182.564357666957, 28450.146495605164, 960.5869476125193, 997.2022382094295, 1027.2141811514198, 1030.5311083457009, 1092.847001419802, 14336.21150836714, 14647.633809154644, 14815.777763333559, 15069.397224111131, 15112.319945602474, 389929.0, 392996.0, 396057.0, 396201.0, 396891.0, 32523.0, 32630.83684581562, 32646.347073058405, 32677.67322326794, 32696.0, 1047.8166320893965, 1133.7845809296207, 1149.6033868315417, 1184.9644510664693, 1188.304841667634, 27375.589366159125, 28833.56749648715, 28884.277893052, 28974.85512572508, 29274.707252927197, 40137.598624013386, 40550.797246014765, 40602.0, 40631.39052914268, 40717.796411017756, 293003.0, 295627.6967536423, 295664.0, 295722.0, 295846.0, 20568.177272909514, 21803.78196218081, 21996.89001555046, 22057.448563786034, 22111.557768844854, 39994.600053999086, 40223.79888100541, 40529.797351013054, 41274.0, 41431.7928410356, 34750.47874281938, 35370.46944295889, 35698.894627118214, 35833.0, 35881.282374352886, 34428.65571344355, 34822.30355392928, 35354.82322588371, 35405.291894161455, 35469.29061418809, 31080.0, 31196.844015779774, 31386.372272554876, 31392.68607313989, 36166.63833361738, 30163.0, 32335.149877370302, 32379.838100809346, 32540.51189232116, 32863.507047394785, 25215.243542693013, 25276.368090797143, 25350.239492815246, 25454.0, 25856.482870342865], "value": 17516.331073828027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.50427418710547, 366.7982609564739, 371.4595263891038, 376.63654573336726, 387.59689922480624, 15816.683666326666, 16274.593135171612, 16960.0, 16971.915140424313, 16993.915030424847, 16005.439809606665, 16378.344866205367, 17236.224369903353, 17271.74092388615, 17308.48074557762, 5019.849404517861, 5099.4390617032095, 5144.202648589456, 5194.766235519411, 5248.02911461379, 3642.581103173129, 3766.114962983697, 3766.152615661482, 3893.59117292683, 5013.548780609744, 6009.1587177795145, 6132.632042077467, 6134.4478996890275, 6138.14066030756, 6140.263168419796, 5079.949200507985, 5413.593980451482, 6080.604760690541, 6115.755369785204, 6116.296625888013, 3312.3706495765728, 4912.926306105412, 5314.5216930476445, 5323.600729945231, 5323.653962492425, 11903.285802851857, 12201.328926909106, 12233.388330583435, 12323.630291091282, 12393.876061239362, 1926.0658580588404, 2009.9799002009938, 2052.8973551322374, 2148.9985587197393, 2235.7205349331334, 9088.091190880925, 9202.539873006323, 9206.585703643352, 9528.333016688835, 9554.713358599252, 1728.5764987577998, 1793.3992112642281, 1811.8550515958823, 1819.699749541324, 1848.8243616856378, 46410.53589464096, 54029.459705402835, 62445.68777156131, 62738.686306568175, 65140.67429662869, 9203.263738900872, 9792.16766574835, 9832.655857044969, 9900.851487227554, 10083.495825208856, 13529.797053044213, 13604.523841665494, 13624.727505449835, 13647.181169129686, 13662.11196272239, 6645.051110066103, 6653.800385988428, 6703.899441508382, 6785.389314961677, 6889.414399775975, 6039.909401358983, 6106.358832322631, 6128.816135515942, 6329.955557333081, 6363.649999249993, 4211.642010429086, 4287.078278170208, 4305.31115021595, 4398.604125628709, 4410.713303635253, 1803.6482885837136, 1804.3865085870866, 1832.5701771849385, 1844.0, 1850.1027001904065, 812.8374325134997, 831.584207896052, 873.9344549158839, 901.833160865242, 902.1970446302796, 16354.67290654204, 16712.0, 16889.746653800205, 16979.91510042442, 17350.826491735173, 804.8873157757919, 811.4522697179498, 864.9048604653609, 893.718478679214, 907.2923119966437, 9230.76923076915, 9645.688850028753, 9686.612535498642, 9699.078587534173, 9761.121499065119, 351600.0, 353288.0, 378512.0, 391374.0, 393505.0, 45329.54670453319, 47168.528314716415, 57974.42025579775, 76027.0, 77460.61269693729, 788.6175205025557, 820.3109388114013, 858.965641374338, 868.934829887761, 878.8989266234337, 15284.15937123469, 15449.459268925533, 15535.611609709847, 15716.449924252596, 16084.839151608803, 32546.72267733656, 34846.825765871006, 35312.0, 36298.637013630585, 36355.0, 44434.0, 46607.53392466032, 48663.0, 50943.23585146152, 51383.74308128435, 7538.208488108669, 7608.80977975555, 7703.845923081395, 7714.768556943301, 7930.603469826601, 8199.467034642728, 11706.941465292619, 11907.583234586747, 12130.514779408724, 12157.392130393622, 9392.107749763762, 10267.0, 10296.227782916161, 10416.166706663296, 10476.790464190826, 10186.74533136648, 10232.948835255776, 10297.845532316871, 10361.533730982275, 10509.579616815241, 10222.6422075227, 10428.217883658908, 10473.266871318934, 10478.423686697304, 10802.567897284021, 7736.1490236075115, 7748.186440423674, 7756.0304961879765, 7807.492512986638, 7958.761237162895, 9625.56684949165, 10387.480625968521, 10454.947725261325, 10506.0, 10574.577016919546], "value": 7877.161115447738, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1192.2190964917982, 1304.9021323400748, 1378.9379477923496, 1447.775594782809, 1690.9746353804687, 7341.265873412663, 7685.730999415022, 7695.884561731572, 7725.768226953186, 7819.569923654197, 7541.660625271862, 7723.652435640395, 7730.5361678299205, 7741.071071471417, 7748.6900523978975, 2183.0, 2202.6893998071123, 2203.3389983005036, 2210.171185805323, 2210.4363387336207, 2191.791779780918, 2212.3473575295247, 2241.3388050525054, 2241.9551608967813, 2242.9102835886547, 2122.8301735861096, 2136.5513242219076, 2181.8036376726172, 2209.1826024371007, 2211.0381983837, 2067.6071546406133, 2081.2507497301112, 2083.8645488043303, 2084.718562993992, 2088.2169186554966, 2052.5176583502866, 2080.9895950520304, 2112.302940029802, 2119.978800212009, 2121.1303365620174, 7540.849183016309, 7571.772846814604, 7645.847083058364, 7648.770536883847, 7797.181295963956, 4527.7056991295785, 4681.087187998308, 4684.297355396684, 4686.718796872198, 4694.319323698079, 2674.9465010699873, 2859.7283258090447, 2910.301527633374, 2915.9125226243245, 2920.7079292070835, 941.9199368053723, 952.8665986761858, 958.942463452195, 960.4717405426987, 966.4974213409058, 10328.328658637165, 10483.790324193473, 10496.21278404115, 10508.264421490423, 10513.158947284199, 3946.1515774108702, 4007.5992400760274, 4028.335324671455, 4041.0907545802547, 4099.057216840143, 8285.42002059862, 8328.6668533258, 8332.16678332162, 8351.0, 8358.45670031446, 4456.086502267028, 4481.305397663367, 4484.506704262529, 4486.147631949919, 4492.797824097924, 3584.766990145632, 3989.222101690201, 4108.137291168829, 4120.320147175742, 4165.97917010413, 3323.7507186961075, 3345.5818022747158, 3396.269801992534, 3427.7086447652227, 3453.3956557602824, 984.3995162950595, 995.4375777685584, 1011.4184344002228, 1023.6928921323573, 1029.8506716526213, 835.7726658455271, 848.3637272045966, 861.6208868098017, 889.5374405309333, 893.0444424465759, 5190.143626301618, 5245.160774276097, 5353.9196912046355, 5403.83788486346, 5407.459254074561, 388.2874924513493, 392.8389360362295, 412.4967539601681, 419.90342221288665, 420.18064773691424, 3684.09739613791, 3781.111438811877, 3784.356659367859, 3794.6584807366917, 3807.9428808567895, 9097.590608422637, 9378.90621093794, 9454.196393306645, 9522.143007129253, 9541.332106752461, 9433.245340372754, 9446.622135114518, 9452.385594936308, 9503.429794212369, 9511.096445837635, 6771.492138089663, 7213.062301900719, 7237.746678866214, 7252.1297444305965, 7275.708971641181, 5472.781088756406, 5555.7499912504845, 5633.521250649701, 5664.85837854057, 5753.050746626927, 8699.565021749015, 8814.427062240933, 8926.955365223132, 8939.463632182089, 8943.329250306122, 8834.602442889956, 8902.154295341932, 8918.777030574287, 9056.547172641473, 9070.591823367833, 5934.792282270272, 6519.315471875574, 6702.463802895659, 6801.353871382409, 6872.759453419107, 7222.386097181588, 7471.589062601609, 7488.251174882468, 7490.812729681584, 7506.43701722384, 6562.081308616893, 6675.299093595103, 6734.9326506734305, 6785.491088168308, 6880.449564034965, 6574.112494813139, 6596.670166491752, 6615.0, 6627.834304142435, 6752.189737231367, 6388.8083357499345, 6424.935750642434, 6428.935710642833, 6440.581362211441, 6443.581167224115, 4473.798679059385, 4505.887352816206, 4668.743219122981, 4706.1764191267075, 4712.7407992559365, 4475.776211189363, 4734.147853386424, 4770.189067858541, 4783.617310615073, 4814.879628009187], "value": 4004.353146533961, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.9364339845235, 294.1587061005524, 299.20262500436337, 305.523383521706, 305.68819803800125, 4680.812767489305, 4825.758712064396, 4843.280635374435, 4844.903101937964, 4848.539388758067, 4546.3180522921575, 4714.292856071591, 4759.976200119003, 4765.928511072337, 4780.784864681089, 3712.9628703712956, 3751.2872554214614, 3756.924861502768, 3759.8308076136504, 3806.3148633246005, 3610.9277814443694, 3682.6133256008134, 3780.6786423154067, 3781.45168950502, 3792.412176112707, 3734.3091528067257, 3744.8876533704033, 3758.6696248326075, 3764.7552909060823, 3773.8301776420126, 3697.334479793636, 3715.4055351143957, 3717.5538935327663, 3721.776693398405, 3738.719596030309, 3284.1625385526777, 3294.275259442919, 3301.290222602128, 3307.851146698404, 3326.617438994498, 4605.240135377659, 4639.443266807971, 4707.199776038082, 4713.198756211452, 4721.291806229059, 4283.528811830696, 4320.0, 4322.697411181219, 4322.697411181219, 4332.1985432695055, 5034.899302013976, 5054.342935418409, 5060.873478163038, 5072.239164125411, 5090.211017292326, 3352.6312105668358, 3537.2748586539697, 3556.928861422757, 3642.453631955201, 3645.2891686121216, 5220.425753167148, 5234.293370394986, 5241.554467870235, 5242.6330156889035, 5260.8684782880355, 3523.9295214095573, 3568.5360903082433, 3569.714422846166, 3575.8212089395424, 3578.481120237603, 3606.611454589949, 3619.4027985382645, 3627.1657518770303, 3647.5805282392867, 3657.5428071491065, 4062.390641403813, 4270.679699022586, 4274.26447073873, 4279.251131052053, 4287.121140166259, 5043.420006699276, 5050.520200580939, 5085.186370180753, 5108.697282193091, 5120.411152717411, 1216.4525963316544, 1242.186367929008, 1261.832804655708, 1266.6326765238161, 1283.4288741509938, 803.8753993130957, 816.5386556595623, 826.8057006603443, 833.8999320081629, 835.4026870787416, 4034.45534852797, 4041.9288888444585, 4052.0882801369457, 4056.553779084298, 4058.1680755445063, 4653.930191047137, 4661.790219440133, 4663.720176789404, 4664.930026049612, 4690.835820746258, 4027.657649099801, 4061.0, 4092.529359123679, 4096.672266218696, 4111.568285330057, 2375.4298968247494, 2532.898684052654, 2536.9492610147695, 2537.2134638262196, 2537.3529749913655, 4431.33529970507, 4433.024734558392, 4441.578050085237, 4457.598816106566, 4510.376264544761, 4713.505081966413, 4717.38185307151, 4717.976410117927, 4730.172219861511, 4765.164726987437, 4387.517373088957, 4412.367424053121, 4620.7227566345455, 5074.771635276347, 5080.390353157644, 5317.361916570037, 5355.30381050461, 5362.168863826113, 5362.892742145214, 5387.0, 5229.084910140787, 5242.18746094356, 5242.895142097213, 5248.6588371755715, 5256.342957130359, 4885.340479035427, 4913.7713343533105, 4961.0, 5032.521910418504, 5033.597312214941, 3718.200586873835, 3724.9011541595837, 3726.124360775161, 3769.2838360711376, 3773.0, 5119.923201151912, 5343.465653434625, 5347.475969348717, 5355.384130824849, 5363.0, 5021.648484606042, 5160.48395160496, 5173.22401639757, 5208.192730126836, 5208.4270730220405, 5175.9741201293755, 5188.377394712658, 5191.480851914778, 5195.0, 5199.792008319776, 4845.2732090186755, 5005.899882002413, 5099.949000509948, 5101.795928162832, 5119.616028797929, 5140.399342588437, 5180.7409629519125, 5182.740862956762, 5191.402988656353, 5192.350956130484, 5072.239164125263, 5075.390953085654, 5086.160783470834, 5086.898262034812, 5098.311727916832], "value": 3747.4139731292594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2938403909603, 620.2216218645597, 653.1182903080839, 658.7359633018394, 710.9466789990748, 12281.938590307047, 12612.62162135135, 12914.870851291507, 13413.061085724003, 13414.530491432803, 12840.101192916476, 12845.67885802853, 12982.0, 12987.870121298783, 12998.155119917199, 621.6270237857273, 771.5833449937028, 773.331068625639, 795.8965334506506, 799.400449662753, 770.7495064104188, 771.4599780153886, 774.4230548241568, 774.8798936164903, 774.8992630957968, 814.1939479914871, 814.4705941138249, 814.771863878115, 815.2499700275731, 815.9306458950966, 641.7272659119878, 771.7646117934056, 772.6677528662673, 793.6349279331514, 793.7340990768099, 591.1635036423455, 591.9023361145406, 591.9496842768369, 592.236015539953, 592.4194289596177, 12842.165259258118, 12862.292573908431, 12866.678333041655, 12877.356132193352, 12904.354782260849, 10909.672709818718, 11687.357195354252, 11751.941240293829, 12084.214526055779, 12234.81647775284, 11143.498542565603, 11187.0, 11547.480363383667, 11623.418829058597, 11646.59236926712, 4108.096218831853, 4133.028738246509, 4186.518550366716, 4255.425517555122, 4303.956960430387, 53837.73081134569, 55179.44820551783, 55307.170392444146, 55943.72028139874, 55975.0, 9875.60497580103, 9943.45876389161, 9973.351732137533, 10013.799724005625, 10137.898621013843, 18038.098095095193, 18043.729344059848, 18070.283323084284, 18088.457346279632, 18094.457166285032, 6673.599584024877, 6681.966590167018, 6689.063531105649, 6711.865762684719, 6874.690638921261, 3632.5277713897553, 3673.228621989412, 3675.448682697563, 3691.5754688210664, 3762.360398732222, 2689.5562232231464, 2780.0686769931895, 2780.7358300961378, 2796.384795345021, 2798.0, 469.77216050215617, 480.06627110270887, 490.85274417674555, 494.5376073371409, 494.97772600233077, 436.943197384338, 484.4041828550902, 533.4931814775979, 588.6879953624585, 593.2376895689019, 7502.174760776419, 7633.5419874807685, 7637.770866874002, 7680.500767450098, 7794.766157015299, 520.0249532127261, 531.8590573498026, 572.9800954301351, 605.6487237402296, 607.8814631146972, 3506.631803660579, 3718.5723641781, 3776.6789822864816, 3777.9219942830687, 3782.3759079751535, 85881.57059214664, 86971.56514217389, 88092.0, 88700.5564972171, 88718.0, 77045.0, 78727.21272787199, 78926.60536697395, 79113.60443197747, 79673.20326796657, 68910.0, 69933.0, 71057.0, 71430.64284678648, 71512.0, 7252.673629686782, 7427.925720742724, 7580.431467639839, 7597.164311925573, 7626.96186519086, 40076.0, 40636.390454142624, 42117.0, 42133.57866421419, 42399.152016960106, 38932.0, 48284.0, 49317.01365972589, 52256.21615675692, 53188.936221274584, 9355.204807591432, 9444.102810233016, 9568.56941437623, 9709.029097090235, 9903.306768526134, 10665.200109991936, 10769.368723098758, 10969.396683182182, 11058.447077646246, 11279.605213817476, 9519.0, 9583.712488625353, 9660.903390966001, 9848.06443387877, 10348.482575871327, 9268.582913768762, 9269.582868771056, 9285.4892980884, 9311.674091406769, 9352.205062569758, 9417.293702972442, 9763.609455621696, 9846.0, 10040.435645345797, 10248.795024099327, 7857.607119643881, 7930.444868859356, 8420.5789710513, 8560.299714557386, 8677.739667809976, 8097.2307630774985, 8122.75631731049, 8558.0, 8592.527410992456, 8682.0], "value": 6134.977242432922, "unit": "score"}], "name": "dromaeo_css", "value": 6257.424518753253, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 131.0, 181.0, 131.0, 133.0, 164.0, 141.0, 192.0, 136.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 159.0, 164.0, 162.0, 160.0, 162.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 114.0, 76.0, 77.0, 77.0, 77.0, 99.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 116.0, 86.0, 86.0, 87.0, 117.0, 87.0, 87.0, 131.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 90.0, 84.0, 85.0, 87.0, 85.0, 116.0, 84.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 143.0, 141.0, 133.0, 133.0, 128.0, 129.0, 142.0, 132.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 166.0, 167.0, 166.0, 166.0, 171.0, 168.0, 175.0, 171.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 66.0, 67.0, 72.0, 67.0, 66.0, 66.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1553.0, "alertThreshold": 2.0}]} 01:53:02 INFO - Return code: 0 01:53:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:53:02 INFO - # TBPL SUCCESS # 01:53:02 INFO - Running post-action listener: _resource_record_post_action 01:53:02 INFO - ##### 01:53:02 INFO - ##### Finished run-tests step (success) 01:53:02 INFO - ##### 01:53:02 INFO - Running post-run listener: _resource_record_post_run 01:53:03 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553885696; Read time: 12; Write time: 1536196 01:53:03 INFO - TinderboxPrint: CPU usage
13.3% 01:53:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:53:03 INFO - TinderboxPrint: I/O write bytes / time
553,885,696 / 1,536,196 01:53:03 INFO - TinderboxPrint: CPU idle
8,342.2 (86.7%) 01:53:03 INFO - TinderboxPrint: CPU user
1,217.4 (12.6%) 01:53:03 INFO - TinderboxPrint: Swap in / out
0 / 0 01:53:03 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 263200768; Read time: 0; Write time: 968640 01:53:03 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290684928; Read time: 12; Write time: 567556 01:53:03 INFO - Running post-run listener: _upload_blobber_files 01:53:03 INFO - Blob upload gear active. 01:53:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:53:03 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 01:53:03 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'] 01:53:03 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 01:53:04 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:07 INFO - (blobuploader) - INFO - Done attempting. 01:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:08 INFO - (blobuploader) - INFO - Done attempting. 01:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:09 INFO - (blobuploader) - INFO - Done attempting. 01:53:09 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:09 INFO - Return code: 0 01:53:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b13f5200e289ac445e6b74bd653fef1ecc31a03bb16578d278fed78f8c095b70a8bdb207c69f284975c2cb96fab700d3b53f7750ca0697f2c7c388a7d3732f6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33903e5da687af05c92c88bb9726ed4007f5363e226aa4a9d12e777cec953922286572641459469184d64b7681c21b324e959e97e45842a2240047c1656d42fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f62bee5fbac6f74179a7288b94a5ff234a2470d545c17b75d186a20d5141d73e091073f37baa6b399eb4383eb3a8f265ec9b4abb52dc585bd8f412fee4fd22dc"} 01:53:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:09 INFO - Contents: 01:53:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b13f5200e289ac445e6b74bd653fef1ecc31a03bb16578d278fed78f8c095b70a8bdb207c69f284975c2cb96fab700d3b53f7750ca0697f2c7c388a7d3732f6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33903e5da687af05c92c88bb9726ed4007f5363e226aa4a9d12e777cec953922286572641459469184d64b7681c21b324e959e97e45842a2240047c1656d42fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f62bee5fbac6f74179a7288b94a5ff234a2470d545c17b75d186a20d5141d73e091073f37baa6b399eb4383eb3a8f265ec9b4abb52dc585bd8f412fee4fd22dc"} 01:53:09 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:09 INFO - Copying logs to upload dir... 01:53:09 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.142087 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-21 01:53:08.812054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:08.815937) ========= 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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b13f5200e289ac445e6b74bd653fef1ecc31a03bb16578d278fed78f8c095b70a8bdb207c69f284975c2cb96fab700d3b53f7750ca0697f2c7c388a7d3732f6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33903e5da687af05c92c88bb9726ed4007f5363e226aa4a9d12e777cec953922286572641459469184d64b7681c21b324e959e97e45842a2240047c1656d42fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f62bee5fbac6f74179a7288b94a5ff234a2470d545c17b75d186a20d5141d73e091073f37baa6b399eb4383eb3a8f265ec9b4abb52dc585bd8f412fee4fd22dc"} build_url:https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/I-_Ecgh6RLWegNKs7np98Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b13f5200e289ac445e6b74bd653fef1ecc31a03bb16578d278fed78f8c095b70a8bdb207c69f284975c2cb96fab700d3b53f7750ca0697f2c7c388a7d3732f6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33903e5da687af05c92c88bb9726ed4007f5363e226aa4a9d12e777cec953922286572641459469184d64b7681c21b324e959e97e45842a2240047c1656d42fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f62bee5fbac6f74179a7288b94a5ff234a2470d545c17b75d186a20d5141d73e091073f37baa6b399eb4383eb3a8f265ec9b4abb52dc585bd8f412fee4fd22dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:08.841324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:08.841703) ========= 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=745a4373a2a16df560f216e000000264-1466497396.327402-1235350786 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:53:08.924077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:53:08.924372) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 01:53:08.924667) ========= ========= Total master_lag: 0.32 =========