builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1467017725.9 results: success (0) buildid: 20160627010724 builduid: 9798a55cb3c8415b86dc02a64391c1bc revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:25.897312) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:25.897776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:25.898067) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:25.929758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:25.930029) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 01:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.2M=0s 2016-06-27 01:55:26 (95.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:26.062690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:26.062971) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:26.115224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:55:26.115619) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9688cac5afbe215406ac95aa1a7972960666ca1c --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 9688cac5afbe215406ac95aa1a7972960666ca1c --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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 01:55:26,217 truncating revision to first 12 chars 2016-06-27 01:55:26,217 Setting DEBUG logging. 2016-06-27 01:55:26,217 attempt 1/10 2016-06-27 01:55:26,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9688cac5afbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 01:55:26,961 unpacking tar archive at: fx-team-9688cac5afbe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.083345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 01:55:27.212766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:27.213040) ========= script_repo_revision: 9688cac5afbe215406ac95aa1a7972960666ca1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:27.213419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:27.213757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 01:55:27.225156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-27 01:55:27.225442) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:55:27 INFO - MultiFileLogger online at 20160627 01:55:27 in /builds/slave/test 01:55:27 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:55:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:55:27 INFO - {'append_to_log': False, 01:55:27 INFO - 'base_work_dir': '/builds/slave/test', 01:55:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:55:27 INFO - 'branch': 'Fx-Team-Non-PGO', 01:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:55:27 INFO - 'config_files': ('talos/linux_config.py',), 01:55:27 INFO - 'default_actions': ('clobber', 01:55:27 INFO - 'read-buildbot-config', 01:55:27 INFO - 'download-and-extract', 01:55:27 INFO - 'populate-webroot', 01:55:27 INFO - 'create-virtualenv', 01:55:27 INFO - 'install', 01:55:27 INFO - 'run-tests'), 01:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:55:27 INFO - 'download_minidump_stackwalk': True, 01:55:27 INFO - 'download_symbols': 'ondemand', 01:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 01:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 01:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:55:27 INFO - 'installer_path': 'installer.exe', 01:55:27 INFO - 'log_level': 'info', 01:55:27 INFO - 'log_name': 'talos', 01:55:27 INFO - 'log_to_console': True, 01:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:55:27 INFO - 'opt_config_files': (), 01:55:27 INFO - 'pip_index': False, 01:55:27 INFO - 'sps_profile': False, 01:55:27 INFO - 'sps_profile_interval': 0, 01:55:27 INFO - 'suite': 'dromaeojs', 01:55:27 INFO - 'system_bits': '32', 01:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:55:27 INFO - 'title': 'talos-linux64-ix-061', 01:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:55:27 INFO - 'use_talos_json': True, 01:55:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:55:27 INFO - 'work_dir': 'build'} 01:55:27 INFO - ##### 01:55:27 INFO - ##### Running clobber step. 01:55:27 INFO - ##### 01:55:27 INFO - Running pre-action listener: _resource_record_pre_action 01:55:27 INFO - Running main action method: clobber 01:55:27 INFO - rmtree: /builds/slave/test/build 01:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:55:28 INFO - Running post-action listener: _resource_record_post_action 01:55:28 INFO - ##### 01:55:28 INFO - ##### Finished clobber step (success) 01:55:28 INFO - ##### 01:55:28 INFO - ##### 01:55:28 INFO - ##### Running read-buildbot-config step. 01:55:28 INFO - ##### 01:55:28 INFO - Running pre-action listener: _resource_record_pre_action 01:55:28 INFO - Running main action method: read_buildbot_config 01:55:28 INFO - Using buildbot properties: 01:55:28 INFO - { 01:55:28 INFO - "project": "", 01:55:28 INFO - "product": "firefox", 01:55:28 INFO - "script_repo_revision": "production", 01:55:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:55:28 INFO - "repository": "", 01:55:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:55:28 INFO - "buildid": "20160627010724", 01:55:28 INFO - "pgo_build": "False", 01:55:28 INFO - "basedir": "/builds/slave/test", 01:55:28 INFO - "buildnumber": 1885, 01:55:28 INFO - "slavename": "talos-linux64-ix-061", 01:55:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:55:28 INFO - "platform": "ubuntu64_hw", 01:55:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:55:28 INFO - "branch": "fx-team", 01:55:28 INFO - "repo_path": "integration/fx-team", 01:55:28 INFO - "revision": "9688cac5afbe215406ac95aa1a7972960666ca1c", 01:55:28 INFO - "stage_platform": "linux64", 01:55:28 INFO - "builduid": "9798a55cb3c8415b86dc02a64391c1bc", 01:55:28 INFO - "slavebuilddir": "test" 01:55:28 INFO - } 01:55:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:55:28 INFO - Running post-action listener: _resource_record_post_action 01:55:28 INFO - ##### 01:55:28 INFO - ##### Finished read-buildbot-config step (success) 01:55:28 INFO - ##### 01:55:28 INFO - ##### 01:55:28 INFO - ##### Running download-and-extract step. 01:55:28 INFO - ##### 01:55:28 INFO - Running pre-action listener: _resource_record_pre_action 01:55:28 INFO - Running main action method: download_and_extract 01:55:28 INFO - mkdir: /builds/slave/test/build/tests 01:55: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:55:28 INFO - https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:55:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:55:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:55:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:34 INFO - Downloaded 1361 bytes. 01:55:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:55:34 INFO - Using the following test package requirements: 01:55:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:55:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:55:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'jsshell-linux-x86_64.zip'], 01:55:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:55:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:55:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:55:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:55:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:55:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:55:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:55:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:55: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:55:34 INFO - https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:38 INFO - Downloaded 22712973 bytes. 01:55:38 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:55:38 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:55:39 INFO - Return code: 0 01:55:39 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:55: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:55:39 INFO - https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:41 INFO - Downloaded 22712973 bytes. 01:55:41 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:55:41 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:55:42 INFO - Return code: 0 01:55: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:55:42 INFO - https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:43 INFO - Downloaded 14405240 bytes. 01:55:43 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:55:43 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:55:44 INFO - Return code: 0 01:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:44 INFO - https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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:55:45 INFO - Downloaded 56283182 bytes. 01:55:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:45 INFO - mkdir: /builds/slave/test/properties 01:55:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:45 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:45 INFO - Contents: 01:55:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:55:46 INFO - Running post-action listener: _resource_record_post_action 01:55:46 INFO - Running post-action listener: set_extra_try_arguments 01:55:46 INFO - ##### 01:55:46 INFO - ##### Finished download-and-extract step (success) 01:55:46 INFO - ##### 01:55:46 INFO - ##### 01:55:46 INFO - ##### Running populate-webroot step. 01:55:46 INFO - ##### 01:55:46 INFO - Running pre-action listener: _resource_record_pre_action 01:55:46 INFO - Running main action method: populate_webroot 01:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:46 INFO - '--tppagecycles', 01:55:46 INFO - '7'], 01:55:46 INFO - 'tests': ['tsvgm']}}, 01:55:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:55:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:55:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['damp', 'tps']}, 01:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['damp', 'tps']}, 01:55:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['dromaeo_dom']}, 01:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['basic_compositor_video']}, 01:55:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:55:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['a11yr', 01:55:46 INFO - 'ts_paint', 01:55:46 INFO - 'tpaint', 01:55:46 INFO - 'sessionrestore', 01:55:46 INFO - 'sessionrestore_no_auto_restore', 01:55:46 INFO - 'tabpaint']}, 01:55:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tsvgx', 01:55:46 INFO - 'tsvgr_opacity', 01:55:46 INFO - 'tart', 01:55:46 INFO - 'tscrollx', 01:55:46 INFO - 'cart']}, 01:55:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:55:46 INFO - 'tsvgr_opacity', 01:55:46 INFO - 'tart', 01:55:46 INFO - 'tscrollx', 01:55:46 INFO - 'cart']}, 01:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s'], 01:55:46 INFO - 'tests': ['tp5o']}, 01:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'tests': ['tp5o']}, 01:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--disable-e10s', 01:55:46 INFO - '--xperf_path', 01:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:46 INFO - 'tests': ['tp5n']}, 01:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:46 INFO - 'talos_options': ['--xperf_path', 01:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:46 INFO - 'tests': ['tp5n']}}, 01:55:46 INFO - 'talos.zip': {'path': '', 01:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:46 INFO - Running post-action listener: _resource_record_post_action 01:55:46 INFO - ##### 01:55:46 INFO - ##### Finished populate-webroot step (success) 01:55:46 INFO - ##### 01:55:46 INFO - ##### 01:55:46 INFO - ##### Running create-virtualenv step. 01:55:46 INFO - ##### 01:55:46 INFO - Running pre-action listener: _resource_record_pre_action 01:55:46 INFO - Running main action method: create_virtualenv 01:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:46 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:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:46 INFO - Using real prefix '/usr' 01:55:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:49 INFO - Installing pip.................done. 01:55:49 INFO - Return code: 0 01:55:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55: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:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:49 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:55:49 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:55:49 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:55:49 INFO - Using env: {'DISPLAY': ':0', 01:55:49 INFO - 'HOME': '/home/cltbld', 01:55:49 INFO - 'LANG': 'en_US.UTF-8', 01:55:49 INFO - 'LANGUAGE': 'en_US:en', 01:55:49 INFO - 'LOGNAME': 'cltbld', 01:55:49 INFO - 'MAIL': '/var/mail/cltbld', 01:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:49 INFO - 'MOZ_NO_REMOTE': '1', 01:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:49 INFO - 'NO_EM_RESTART': '1', 01:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:49 INFO - 'PWD': '/builds/slave/test', 01:55:49 INFO - 'SHELL': '/bin/bash', 01:55:49 INFO - 'SHLVL': '1', 01:55:49 INFO - 'TERM': 'linux', 01:55:49 INFO - 'TMOUT': '86400', 01:55:49 INFO - 'USER': 'cltbld', 01:55:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:49 INFO - '_': '/tools/buildbot/bin/python'} 01:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:49 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:55:49 INFO - Cleaning up... 01:55:49 INFO - Return code: 0 01:55:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:55: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:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:49 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:55:49 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:55:49 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:55:49 INFO - Using env: {'DISPLAY': ':0', 01:55:49 INFO - 'HOME': '/home/cltbld', 01:55:49 INFO - 'LANG': 'en_US.UTF-8', 01:55:49 INFO - 'LANGUAGE': 'en_US:en', 01:55:49 INFO - 'LOGNAME': 'cltbld', 01:55:49 INFO - 'MAIL': '/var/mail/cltbld', 01:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:49 INFO - 'MOZ_NO_REMOTE': '1', 01:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:49 INFO - 'NO_EM_RESTART': '1', 01:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:49 INFO - 'PWD': '/builds/slave/test', 01:55:49 INFO - 'SHELL': '/bin/bash', 01:55:49 INFO - 'SHLVL': '1', 01:55:49 INFO - 'TERM': 'linux', 01:55:49 INFO - 'TMOUT': '86400', 01:55:49 INFO - 'USER': 'cltbld', 01:55:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:49 INFO - '_': '/tools/buildbot/bin/python'} 01:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:49 INFO - Downloading/unpacking psutil>=3.1.1 01:55:49 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:55:49 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:55:49 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:55:49 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:55:49 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:55:49 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:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:51 INFO - Installing collected packages: psutil 01:55:51 INFO - Running setup.py install for psutil 01:55:51 INFO - building 'psutil._psutil_linux' extension 01:55:51 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:55:51 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:55:51 INFO - building 'psutil._psutil_posix' extension 01:55:51 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:55:51 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:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:52 INFO - Successfully installed psutil 01:55:52 INFO - Cleaning up... 01:55:53 INFO - Return code: 0 01:55:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:55: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:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:55: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 mozsystemmonitor==0.3 01:55:53 INFO - Using env: {'DISPLAY': ':0', 01:55:53 INFO - 'HOME': '/home/cltbld', 01:55:53 INFO - 'LANG': 'en_US.UTF-8', 01:55:53 INFO - 'LANGUAGE': 'en_US:en', 01:55:53 INFO - 'LOGNAME': 'cltbld', 01:55:53 INFO - 'MAIL': '/var/mail/cltbld', 01:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:53 INFO - 'MOZ_NO_REMOTE': '1', 01:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:53 INFO - 'NO_EM_RESTART': '1', 01:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:53 INFO - 'PWD': '/builds/slave/test', 01:55:53 INFO - 'SHELL': '/bin/bash', 01:55:53 INFO - 'SHLVL': '1', 01:55:53 INFO - 'TERM': 'linux', 01:55:53 INFO - 'TMOUT': '86400', 01:55:53 INFO - 'USER': 'cltbld', 01:55:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:53 INFO - '_': '/tools/buildbot/bin/python'} 01:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:55: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:55: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:55: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:55: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:55: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:55: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:55:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:55:55 INFO - Installing collected packages: mozsystemmonitor 01:55:55 INFO - Running setup.py install for mozsystemmonitor 01:55:55 INFO - Successfully installed mozsystemmonitor 01:55:55 INFO - Cleaning up... 01:55:55 INFO - Return code: 0 01:55:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:55:55 INFO - Using env: {'DISPLAY': ':0', 01:55:55 INFO - 'HOME': '/home/cltbld', 01:55:55 INFO - 'LANG': 'en_US.UTF-8', 01:55:55 INFO - 'LANGUAGE': 'en_US:en', 01:55:55 INFO - 'LOGNAME': 'cltbld', 01:55:55 INFO - 'MAIL': '/var/mail/cltbld', 01:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:55 INFO - 'MOZ_NO_REMOTE': '1', 01:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:55 INFO - 'NO_EM_RESTART': '1', 01:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:55 INFO - 'PWD': '/builds/slave/test', 01:55:55 INFO - 'SHELL': '/bin/bash', 01:55:55 INFO - 'SHLVL': '1', 01:55:55 INFO - 'TERM': 'linux', 01:55:55 INFO - 'TMOUT': '86400', 01:55:55 INFO - 'USER': 'cltbld', 01:55:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:55 INFO - '_': '/tools/buildbot/bin/python'} 01:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:55 INFO - Downloading/unpacking jsonschema==2.5.1 01:55: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:55: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:55: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:55: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:55: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:55: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:55:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:57 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:57 INFO - warning: no files found matching '*.txt' 01:55:57 INFO - no previously-included directories found matching 'build' 01:55:57 INFO - no previously-included directories found matching 'dist' 01:55:57 INFO - no previously-included directories found matching '.git*' 01:55:57 INFO - Installing collected packages: jsonschema, functools32 01:55:57 INFO - Running setup.py install for functools32 01:55:57 INFO - warning: no files found matching '*.txt' 01:55:57 INFO - no previously-included directories found matching 'build' 01:55:57 INFO - no previously-included directories found matching 'dist' 01:55:57 INFO - no previously-included directories found matching '.git*' 01:55:57 INFO - Successfully installed jsonschema functools32 01:55:57 INFO - Cleaning up... 01:55:57 INFO - Return code: 0 01:55:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:55:57 INFO - Using env: {'DISPLAY': ':0', 01:55:57 INFO - 'HOME': '/home/cltbld', 01:55:57 INFO - 'LANG': 'en_US.UTF-8', 01:55:57 INFO - 'LANGUAGE': 'en_US:en', 01:55:57 INFO - 'LOGNAME': 'cltbld', 01:55:57 INFO - 'MAIL': '/var/mail/cltbld', 01:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:57 INFO - 'MOZ_NO_REMOTE': '1', 01:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:55:57 INFO - 'NO_EM_RESTART': '1', 01:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:57 INFO - 'PWD': '/builds/slave/test', 01:55:57 INFO - 'SHELL': '/bin/bash', 01:55:57 INFO - 'SHLVL': '1', 01:55:57 INFO - 'TERM': 'linux', 01:55:57 INFO - 'TMOUT': '86400', 01:55:57 INFO - 'USER': 'cltbld', 01:55:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:57 INFO - '_': '/tools/buildbot/bin/python'} 01:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:00 INFO - Downloading docopt-0.6.1.tar.gz 01:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:00 INFO - Running setup.py install for blobuploader 01:56:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:00 INFO - Running setup.py install for requests 01:56:01 INFO - Running setup.py install for docopt 01:56:01 INFO - Successfully installed blobuploader requests docopt 01:56:01 INFO - Cleaning up... 01:56:01 INFO - Return code: 0 01:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:01 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:56:01 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:56:01 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:56:01 INFO - Using env: {'DISPLAY': ':0', 01:56:01 INFO - 'HOME': '/home/cltbld', 01:56:01 INFO - 'LANG': 'en_US.UTF-8', 01:56:01 INFO - 'LANGUAGE': 'en_US:en', 01:56:01 INFO - 'LOGNAME': 'cltbld', 01:56:01 INFO - 'MAIL': '/var/mail/cltbld', 01:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:01 INFO - 'MOZ_NO_REMOTE': '1', 01:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:01 INFO - 'NO_EM_RESTART': '1', 01:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:01 INFO - 'PWD': '/builds/slave/test', 01:56:01 INFO - 'SHELL': '/bin/bash', 01:56:01 INFO - 'SHLVL': '1', 01:56:01 INFO - 'TERM': 'linux', 01:56:01 INFO - 'TMOUT': '86400', 01:56:01 INFO - 'USER': 'cltbld', 01:56:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:01 INFO - '_': '/tools/buildbot/bin/python'} 01:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:01 INFO - Running setup.py (path:/tmp/pip-70j4EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:01 INFO - Running setup.py (path:/tmp/pip-ArKzui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:01 INFO - Running setup.py (path:/tmp/pip-1xjYAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:01 INFO - Running setup.py (path:/tmp/pip-QiVsUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:01 INFO - Running setup.py (path:/tmp/pip-fgQqGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:01 INFO - Running setup.py (path:/tmp/pip-CKejpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:02 INFO - Running setup.py (path:/tmp/pip-S9aLyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:02 INFO - Running setup.py (path:/tmp/pip-U3GZKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:02 INFO - Running setup.py (path:/tmp/pip-BqRc0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:02 INFO - Running setup.py (path:/tmp/pip-EYI5EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:02 INFO - Running setup.py (path:/tmp/pip-neEARq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:02 INFO - Running setup.py (path:/tmp/pip-cCwuaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:02 INFO - Running setup.py (path:/tmp/pip-4_X3Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:02 INFO - Running setup.py (path:/tmp/pip-NaiNlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:02 INFO - Running setup.py (path:/tmp/pip-_Wae04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:02 INFO - Running setup.py (path:/tmp/pip-opB6aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:02 INFO - Running setup.py (path:/tmp/pip-kPKREw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:02 INFO - Running setup.py install for manifestparser 01:56:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:02 INFO - Running setup.py install for mozcrash 01:56:03 INFO - Running setup.py install for mozdebug 01:56:03 INFO - Running setup.py install for mozdevice 01:56:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for mozfile 01:56:03 INFO - Running setup.py install for mozhttpd 01:56:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for mozinfo 01:56:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for mozInstall 01:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for mozleak 01:56:03 INFO - Running setup.py install for mozlog 01:56:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for moznetwork 01:56:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:03 INFO - Running setup.py install for mozprocess 01:56:04 INFO - Running setup.py install for mozprofile 01:56:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:04 INFO - Running setup.py install for mozrunner 01:56:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:04 INFO - Running setup.py install for mozscreenshot 01:56:04 INFO - Running setup.py install for moztest 01:56:04 INFO - Running setup.py install for mozversion 01:56:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:04 INFO - Cleaning up... 01:56:04 INFO - Return code: 0 01:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:04 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:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:04 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:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:04 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:56:04 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:56:04 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:56:04 INFO - Using env: {'DISPLAY': ':0', 01:56:04 INFO - 'HOME': '/home/cltbld', 01:56:04 INFO - 'LANG': 'en_US.UTF-8', 01:56:04 INFO - 'LANGUAGE': 'en_US:en', 01:56:04 INFO - 'LOGNAME': 'cltbld', 01:56:04 INFO - 'MAIL': '/var/mail/cltbld', 01:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:04 INFO - 'MOZ_NO_REMOTE': '1', 01:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:04 INFO - 'NO_EM_RESTART': '1', 01:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:04 INFO - 'PWD': '/builds/slave/test', 01:56:04 INFO - 'SHELL': '/bin/bash', 01:56:04 INFO - 'SHLVL': '1', 01:56:04 INFO - 'TERM': 'linux', 01:56:04 INFO - 'TMOUT': '86400', 01:56:04 INFO - 'USER': 'cltbld', 01:56:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:04 INFO - '_': '/tools/buildbot/bin/python'} 01:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:04 INFO - Running setup.py (path:/tmp/pip-5zpSD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:04 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:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:04 INFO - Running setup.py (path:/tmp/pip-FB9D4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:04 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:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:04 INFO - Running setup.py (path:/tmp/pip-xnl525-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:05 INFO - Running setup.py (path:/tmp/pip-8plrIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:05 INFO - Running setup.py (path:/tmp/pip-qT7xDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:05 INFO - Running setup.py (path:/tmp/pip-AHYPTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:05 INFO - Running setup.py (path:/tmp/pip-F03_LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:05 INFO - Running setup.py (path:/tmp/pip-EKD1qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:05 INFO - Running setup.py (path:/tmp/pip-PtdgoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:05 INFO - Running setup.py (path:/tmp/pip-Zc4TOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:05 INFO - Running setup.py (path:/tmp/pip-gFzyGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:05 INFO - Running setup.py (path:/tmp/pip-B5LCym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:05 INFO - Running setup.py (path:/tmp/pip-6GENpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:05 INFO - Running setup.py (path:/tmp/pip-DvSmOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:05 INFO - Running setup.py (path:/tmp/pip-BXXbhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:05 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:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:05 INFO - Running setup.py (path:/tmp/pip-V39c7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:06 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:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:06 INFO - Running setup.py (path:/tmp/pip-HZBJmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:06 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:56:06 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:56:06 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:56:06 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:56:06 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:56:06 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:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:07 INFO - Downloading blessings-1.6.tar.gz 01:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:56:08 INFO - Installing collected packages: blessings 01:56:08 INFO - Running setup.py install for blessings 01:56:08 INFO - Successfully installed blessings 01:56:08 INFO - Cleaning up... 01:56:08 INFO - Return code: 0 01:56:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:08 INFO - Reading from file tmpfile_stdout 01:56:08 INFO - Current package versions: 01:56:08 INFO - argparse == 1.2.1 01:56:08 INFO - blessings == 1.6 01:56:08 INFO - blobuploader == 1.2.4 01:56:08 INFO - docopt == 0.6.1 01:56:08 INFO - functools32 == 3.2.3-2 01:56:08 INFO - jsonschema == 2.5.1 01:56:08 INFO - manifestparser == 1.1 01:56:08 INFO - mozInstall == 1.12 01:56:08 INFO - mozcrash == 0.17 01:56:08 INFO - mozdebug == 0.1 01:56:08 INFO - mozdevice == 0.48 01:56:08 INFO - mozfile == 1.2 01:56:08 INFO - mozhttpd == 0.7 01:56:08 INFO - mozinfo == 0.9 01:56:08 INFO - mozleak == 0.1 01:56:08 INFO - mozlog == 3.2 01:56:08 INFO - moznetwork == 0.27 01:56:08 INFO - mozprocess == 0.22 01:56:08 INFO - mozprofile == 0.28 01:56:08 INFO - mozrunner == 6.11 01:56:08 INFO - mozscreenshot == 0.1 01:56:08 INFO - mozsystemmonitor == 0.3 01:56:08 INFO - moztest == 0.7 01:56:08 INFO - mozversion == 1.4 01:56:08 INFO - psutil == 3.1.1 01:56:08 INFO - requests == 1.2.3 01:56:08 INFO - wsgiref == 0.1.2 01:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:08 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:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:56:08 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:56:08 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:56:08 INFO - Using env: {'DISPLAY': ':0', 01:56:08 INFO - 'HOME': '/home/cltbld', 01:56:08 INFO - 'LANG': 'en_US.UTF-8', 01:56:08 INFO - 'LANGUAGE': 'en_US:en', 01:56:08 INFO - 'LOGNAME': 'cltbld', 01:56:08 INFO - 'MAIL': '/var/mail/cltbld', 01:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:08 INFO - 'MOZ_NO_REMOTE': '1', 01:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:08 INFO - 'NO_EM_RESTART': '1', 01:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:08 INFO - 'PWD': '/builds/slave/test', 01:56:08 INFO - 'SHELL': '/bin/bash', 01:56:08 INFO - 'SHLVL': '1', 01:56:08 INFO - 'TERM': 'linux', 01:56:08 INFO - 'TMOUT': '86400', 01:56:08 INFO - 'USER': 'cltbld', 01:56:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:08 INFO - '_': '/tools/buildbot/bin/python'} 01:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 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:56:08 INFO - Cleaning up... 01:56:08 INFO - Return code: 0 01:56:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:56:08 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:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:56:08 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:56:08 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:56:08 INFO - Using env: {'DISPLAY': ':0', 01:56:08 INFO - 'HOME': '/home/cltbld', 01:56:08 INFO - 'LANG': 'en_US.UTF-8', 01:56:08 INFO - 'LANGUAGE': 'en_US:en', 01:56:08 INFO - 'LOGNAME': 'cltbld', 01:56:08 INFO - 'MAIL': '/var/mail/cltbld', 01:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:08 INFO - 'MOZ_NO_REMOTE': '1', 01:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:08 INFO - 'NO_EM_RESTART': '1', 01:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:08 INFO - 'PWD': '/builds/slave/test', 01:56:08 INFO - 'SHELL': '/bin/bash', 01:56:08 INFO - 'SHLVL': '1', 01:56:08 INFO - 'TERM': 'linux', 01:56:08 INFO - 'TMOUT': '86400', 01:56:08 INFO - 'USER': 'cltbld', 01:56:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:08 INFO - '_': '/tools/buildbot/bin/python'} 01:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:56:08 INFO - Cleaning up... 01:56:08 INFO - Return code: 0 01:56:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:56:08 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:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:08 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 0x7f7c4bd0cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cfa90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', '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:56:08 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:56:08 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:56:08 INFO - Using env: {'DISPLAY': ':0', 01:56:08 INFO - 'HOME': '/home/cltbld', 01:56:08 INFO - 'LANG': 'en_US.UTF-8', 01:56:08 INFO - 'LANGUAGE': 'en_US:en', 01:56:08 INFO - 'LOGNAME': 'cltbld', 01:56:08 INFO - 'MAIL': '/var/mail/cltbld', 01:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:08 INFO - 'MOZ_NO_REMOTE': '1', 01:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:08 INFO - 'NO_EM_RESTART': '1', 01:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:08 INFO - 'PWD': '/builds/slave/test', 01:56:08 INFO - 'SHELL': '/bin/bash', 01:56:08 INFO - 'SHLVL': '1', 01:56:08 INFO - 'TERM': 'linux', 01:56:08 INFO - 'TMOUT': '86400', 01:56:08 INFO - 'USER': 'cltbld', 01:56:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:08 INFO - '_': '/tools/buildbot/bin/python'} 01:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:09 INFO - Downloading/unpacking flake8 01:56:09 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:56:09 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:56:09 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:56:09 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:56:09 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:56:09 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:56:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:56:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:56:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 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:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:11 INFO - no previously-included directories found matching 'docs/_build' 01:56:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:56:11 INFO - Running setup.py install for pep8 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:56:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:56:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:56:11 INFO - no previously-included directories found matching 'docs/_build' 01:56:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:56:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:56:11 INFO - Cleaning up... 01:56:11 INFO - Return code: 0 01:56:11 INFO - Running post-action listener: _resource_record_post_action 01:56:11 INFO - Running post-action listener: _start_resource_monitoring 01:56:12 INFO - Starting resource monitoring. 01:56:12 INFO - ##### 01:56:12 INFO - ##### Finished create-virtualenv step (success) 01:56:12 INFO - ##### 01:56:12 INFO - ##### 01:56:12 INFO - ##### Running install step. 01:56:12 INFO - ##### 01:56:12 INFO - Running pre-action listener: _resource_record_pre_action 01:56:12 INFO - Running main action method: install 01:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:56:12 INFO - Reading from file tmpfile_stdout 01:56:12 INFO - Detecting whether we're running mozinstall >=1.0... 01:56:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:56:12 INFO - Reading from file tmpfile_stdout 01:56:12 INFO - Output received: 01:56:12 INFO - Usage: mozinstall [options] installer 01:56:12 INFO - Options: 01:56:12 INFO - -h, --help show this help message and exit 01:56:12 INFO - -d DEST, --destination=DEST 01:56:12 INFO - Directory to install application into. [default: 01:56:12 INFO - "/builds/slave/test"] 01:56:12 INFO - --app=APP Application being installed. [default: firefox] 01:56:12 INFO - mkdir: /builds/slave/test/build/application 01:56:12 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:56:12 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:56:28 INFO - Reading from file tmpfile_stdout 01:56:28 INFO - Output received: 01:56:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:56:28 INFO - Running post-action listener: _resource_record_post_action 01:56:28 INFO - ##### 01:56:28 INFO - ##### Finished install step (success) 01:56:28 INFO - ##### 01:56:28 INFO - ##### 01:56:28 INFO - ##### Running run-tests step. 01:56:28 INFO - ##### 01:56:28 INFO - Running pre-action listener: _resource_record_pre_action 01:56:28 INFO - Running main action method: run_tests 01:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:28 INFO - Python 2.7.3 01:56:28 INFO - Return code: 0 01:56:28 INFO - grabbing minidump binary from tooltool 01:56: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:56:28 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 0x1907980>, '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 0x1950a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1950f10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:28 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:56:28 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:56:28 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:56:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:28 INFO - Return code: 0 01:56:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:56:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:56:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:56:29 INFO - Return code: 0 01:56:29 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/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:56:29 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/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:56:29 INFO - Using env: {'DISPLAY': ':0', 01:56:29 INFO - 'HOME': '/home/cltbld', 01:56:29 INFO - 'LANG': 'en_US.UTF-8', 01:56:29 INFO - 'LANGUAGE': 'en_US:en', 01:56:29 INFO - 'LOGNAME': 'cltbld', 01:56:29 INFO - 'MAIL': '/var/mail/cltbld', 01:56:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:29 INFO - 'MOZ_NO_REMOTE': '1', 01:56:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:56:29 INFO - 'NO_EM_RESTART': '1', 01:56:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:29 INFO - 'PWD': '/builds/slave/test', 01:56:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:29 INFO - 'SHELL': '/bin/bash', 01:56:29 INFO - 'SHLVL': '1', 01:56:29 INFO - 'TERM': 'linux', 01:56:29 INFO - 'TMOUT': '86400', 01:56:29 INFO - 'USER': 'cltbld', 01:56:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790', 01:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:29 INFO - '_': '/tools/buildbot/bin/python'} 01:56:29 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/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:56:29 INFO - mozversion application_buildid: 20160627010724 01:56:29 INFO - mozversion application_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 01:56:29 INFO - mozversion application_display_name: Nightly 01:56:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:29 INFO - mozversion application_name: Firefox 01:56:29 INFO - mozversion application_remotingname: firefox 01:56:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:56:29 INFO - mozversion application_vendor: Mozilla 01:56:29 INFO - mozversion application_version: 50.0a1 01:56:29 INFO - mozversion platform_buildid: 20160627010724 01:56:29 INFO - mozversion platform_changeset: 9688cac5afbe215406ac95aa1a7972960666ca1c 01:56:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:29 INFO - mozversion platform_version: 50.0a1 01:56:29 INFO - using testdate: 1467017789 01:56:29 INFO - actual date: 1467017789 01:56:29 INFO - starting webserver on 'localhost:49014' 01:56:29 INFO - SUITE-START | Running 2 tests 01:56:29 INFO - TEST-START | dromaeo_css 01:56:29 INFO - operating with platform_type : linux_ 01:56:29 INFO - Initialising browser for dromaeo_css test... 01:56:29 INFO - TEST-INFO | started process 10837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCK8AYa/profile http://localhost:49014/getInfo.html) 01:56:34 INFO - PROCESS | 10837 | __metrics Screen width/height:1600/1200 01:56:34 INFO - PROCESS | 10837 | colorDepth:24 01:56:34 INFO - PROCESS | 10837 | Browser inner width/height: 1024/697 01:56:34 INFO - PROCESS | 10837 | __metrics 01:56:35 INFO - PROCESS | 10837 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:36 INFO - TEST-INFO | 10837: exit 0 01:56:36 INFO - Browser initialized. 01:56:36 INFO - Running cycle 1/1 for dromaeo_css test... 01:56:36 INFO - TEST-INFO | started process 10917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCK8AYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:48 INFO - PROCESS | 10917 | RSS: Main: 175804416 01:56:48 INFO - PROCESS | 10917 | 01:57:39 INFO - PROCESS | 10917 | 1467017859961 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:59:53 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49014/tests/dromaeo/cssquery-ext.html) 01:59:54 INFO - PROCESS | 10917 | RSS: Main: 276455424 01:59:54 INFO - PROCESS | 10917 | 02:02:56 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-ext.html (next: http://localhost:49014/tests/dromaeo/cssquery-jquery.html) 02:02:57 INFO - PROCESS | 10917 | RSS: Main: 260984832 02:02:57 INFO - PROCESS | 10917 | 02:05:59 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49014/tests/dromaeo/cssquery-mootools.html) 02:06:00 INFO - PROCESS | 10917 | RSS: Main: 256393216 02:06:00 INFO - PROCESS | 10917 | 02:09:02 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49014/tests/dromaeo/cssquery-prototype.html) 02:09:02 INFO - PROCESS | 10917 | RSS: Main: 258555904 02:09:02 INFO - PROCESS | 10917 | 02:12:06 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49014/tests/dromaeo/cssquery-yui.html) 02:12:06 INFO - PROCESS | 10917 | RSS: Main: 234307584 02:12:06 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | Cycle 1(1): loaded http://localhost:49014/tests/dromaeo/cssquery-yui.html (next: http://localhost:49014/tests/dromaeo/cssquery-dojo.html) 02:15:09 INFO - PROCESS | 10917 | RSS: Main: 309288960 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | __start_tp_report 02:15:09 INFO - PROCESS | 10917 | _x_x_mozilla_page_load 02:15:09 INFO - PROCESS | 10917 | _x_x_mozilla_page_load_details 02:15:09 INFO - PROCESS | 10917 | |i|pagename|runs| 02:15:09 INFO - PROCESS | 10917 | |0;dojo.html;2621.5936529837873;2656.203139058282;2685.8657067146646;2703.2025552462023;2703.6350092737475;4712.505186955364;4770.3083052957345;4796.760161991895;4843.055604157186;4882.072406242812;4781.90436191276;4829.927551086727;4848.490908454614;4848.684835485691;4914.729689867056;4350.934735978947;4367.475902891658;4369.4756629204385;4421.9336709949375;4489.708168969023;4466.218411777926;4483.08096840147;4525.2533332000185;4540.2054640437955;4543.932175938652;4314.935275970863;4389.561043895616;4444.888877778049;4449;4529.750863702495;4310.31035034393;4317.481902171759;4333.501647310537;4339.891502712426;4396.428464299621;4341.587549182823;4360.106178233455;4361.040571074359;4372.6064654180955;4403.493598236212;4613.423322084739;4714.669973101884;4720.3863497745415;4733.337332773414;4769.928451073237;5112.667676601009;5177.948220517822;5191.169412893956;5200.427952925175;5204.34945631796;5155.072087024334;5200.869978250536;5223.6343455958095;5237.109691352441;5237.8428647140645;4711.387519622427;4723.102610503994;4751.596114330251;4864.513548645107;4865.7323847188745;5207.453217412117;5259.737013149327;5266;5269.71016594091;5285.497877701612;4980.775865086008;4987;5045.47022562633;5045.646804723634;5047.772850221749;4942.802287908444;5030.899382012412;5033.84898453047;5049.065922804293;5063.772130254148;5044.949550504448;5068.214426763858;5082.390113186441;5093.898122037538;5145.974270128625;5057.115004874132;5067.315912351785;5067.366579177603;5072.036313100499;5074.112030394666;4232.470941132358;4256.91486170281;4296.677749168824;4317.007088369693;4330.41539392178;3774.75464094833;3783.50814394127;3785.072657199004;3803.1823158021157;3822.4648549203134;4401.713888597231;4415.161119387306;4417.53615870329;4422.84520041797;4461.420015398043;4588.931166032446;5029.06962211992;5057.418396884332;5095.286659867622;5129.333186685707;4414.933775993362;4422.137683151755;4425.22558552252;4432.578905004019;4450.265706158512;4618.03021365517;4631.675782695179;4637.605803506673;4666.066786642753;4689.20283551797;4723.173444647242;4787.664863459524;4788.04239152164;4801.735904525145;4832.758362081811;5021.974890125526;5091;5112.872178195575;5179.715115668524;5185.196294574347;4783;4795.592374648055;4799.544043315879;4805.27920811881;4844.103840789465;5048.974755126201;5052.69683818972;5055.317532133115;5060.51925067118;5085.7711402986215;4901.9019619608125;5077.466865979019;5115.130427827204;5137.845864624067;5158.45836187195;5007.499250075109;5021.874453138701;5027;5028.170351891897;5058.1401161803315;4838.7338696372035;5003.724795136302;5010.473900240422;5018.42288136869;5025.39695236574;4840.443349014768;4901.877453063702;4906.21500559923;4966.975165124151;4977.303177555217;5020;5022.3219865317715;5027.673201242053;5028.170351892043;5069.467705890828;4785.186518291968;4812.51874812516;4828.7102773833685;4884.584810291165;4886.267059941038 02:15:09 INFO - PROCESS | 10917 | |1;ext.html;555.6253442461373;580.7270582826071;586.6069733278703;587.362711458068;589.1339730596023;26849.597256041176;29267.560986585217;29316.706832931664;29331.853340733265;29345.559816602767;29212.26969325768;45238;46522.30216546746;46619.067618647605;46624.53375466244;7913.3273671737825;8026.5986700664735;8037.156098609649;8038.115807261197;8042.839143217132;7938.682452701885;8025.438219324649;8030.5181689098545;8032.3172530335;8032.558209298486;8011.158828323029;8023.4383593148505;8043.4771739837015;8044.074931382878;8044.316233120163;7881.566513841736;7944.483608565425;7952.767321065216;7953.2842044216295;7958.164392738737;7847.882281765778;7981.082175549828;7997.600119994036;7998.080220774627;8000.4399692021;38734.80632596819;38966.220675586614;39045.80477097625;39049.60950390488;39061.41407878884;2974.2118338640275;3089.119600913729;3090.3138225664884;3116.501359782447;3136.6863313668678;30029.849850750605;30347;30356.24109397283;30750.384992300027;30854.38291234185;3356.127406874206;3356.7314614830757;3374.325134972991;3393.949090763616;3400.2009527760956;262330;262359.0112790991;262567.9999999981;262731;263676;31970.84014579912;33101.17247068843;33171.50242746361;53387;53953.1907021395;34126.65873341284;34154;34212.48681269783;34332;34335.656643433744;12263.448144833505;12318.260904345769;12325.198862074116;12341.62975110748;12342.074344424203;10885.346879187275;10963.50664220112;10975.341479511255;10976.615818446317;10979.17656175774;7784.610769461618;7859.960700196577;7893.329067029367;7936.444448888522;7947.483413578215;3077.7691673124605;3078.6613472518006;3101.5347697845505;3128.89048883288;3150.401423729484;793.5595744361934;837.8282452097305;844.4511067805976;853.8036251662028;917.2157805076697;28273.858630706716;28397;28538.286542836595;29038.709612904022;29210.853945730134;745.4632664481672;889.5241046040467;905.9229965452879;931.1573026411108;956.3544607389983;14392.20842853653;14615.561533154023;14858.182799946107;15076.698466030617;15109.773353399707;391057;394951;395046;395378;396302;49715.254271185964;50933;50998.74500627547;51044;51197.232041519404;1027.157730660851;1077.6605369308643;1084.3927400655816;1139.7492551638627;1146.6502716671496;24389.51220975535;31504;31522.527162093047;31993.840030799696;32226.67773322237;47003.52996469991;47816.521834781204;47819.28271075867;48187.759061204466;48581.27128093152;333442;334729;336745;336806;336905;25010.62399072085;25656.230313090637;26023.479530408906;26048.479030419665;26053.348666283495;42130.578694212665;43254.56745432506;43508.564914351715;44353.33469997888;44678.553214467436;36446.27107457783;37567.81216094011;37653.2469350606;37849.81075094607;37903;36720.449193262655;36894.63105368912;37009.44485832768;37215.25569488541;37644.62355376521;28538.87265255151;31617;36046.27907441784;36197.457038144974;37706.43440348452;31088;32764.672353277114;32898.67101328956;33166.834165829016;33244.83377583193;24496.87751561231;24649.630255545824;24922.750772492043;25258;25622.61566076473 02:15:09 INFO - PROCESS | 10917 | |2;jquery.html;368.1477379865612;375.72008853404213;377.712938166993;380.96761775249104;385.8591614060865;16098.275577599006;17308;17396.913015434904;17623.206955686994;17648.82351176488;11948.402579871015;15474.22628868555;16273.267702953366;16329.918350408261;16893.746593801105;4489.5285994970545;4682.90634187316;4715.198416269225;4715.929261061086;4721.598664113537;3518.542589463379;3711.777293362407;4659.068186362741;5379.354477462691;5682.147677848335;5728.083506638938;5737.741801618937;5761.510271626917;5767.394423585526;5768.596198266123;5297.682139071649;5303.469653034705;5309.123994540896;5312.362516498007;5493.890122197554;3435.7766745161484;5148.768305426265;5176.016556854186;5471.671699698031;5477.370102438231;12565.93717031409;12786.936065319707;12794.616161515169;12854.807177892339;12867.227966321958;1813.8276863697927;1831.615360774239;1834.8440382567499;2006.2175751456944;2272.3296627494765;8281.420300578962;8603.182697643713;9021.954890225572;9035.051319611412;9048.095190480964;1611.8629916457114;1674.6315810521667;1696.355384953722;1731.826817318258;1736.722124460093;59509.7024514879;61596.69201653963;66976.66511667459;67476.32523674799;67535.32464675339;9934.80130397388;9940.502974851228;10011.199104071657;10109.747256318651;10317.9484102579;14141.5050473235;14179.361928713233;14212.076215045989;14216.928915355564;14225.644358890904;6879.484038697117;7002.404795592432;7078.115235595551;7157.534760240567;7426.665800039012;6391.552591318563;6534.869302613921;6564.606123632598;6689.966550167218;6713.630750308682;4471.083427897273;4485.820567177341;4517.164324599959;4523.773811309487;4600.42494688164;1727.3263427263378;1806.4941816291196;1810.3120814090562;1815.2648177488138;1829.1768704083215;693.9555968267724;741.3809469093368;780.7306479264645;838.0571856661256;900.4552245891141;16336.264868080965;16382.426615068416;16482.670346593;16825.831741682672;17292.827071729374;793.2701914238914;797.6291024673554;800.2757504458474;833.3541505333416;841.0454134557199;9110.088991100969;9366.531673416439;9656.855147172799;9665.951670241604;9778.119969202806;384514;388295.7607755487;390087;394388;394933;49438;56485;75519.62240188764;78964;79265.81101283485;876.8202518483696;919.2140719684573;955.4028732042474;961.240619910263;965.4882912056621;15660.216989150726;15752.212389380715;15884.52346429609;15997.760033599272;16073.517794466185;36455.81772091229;36503;37177.4423383644;37414.438783417725;38093;47192.05615887732;52608;52803.511701505806;53470.19794703005;54984.90030199294;6522.21733391996;7127.75052873147;7184.9640751795905;7364.116306043309;7408.518446300973;9264.305177111608;11410.600628977945;11511.136664750346;11697.824532631847;12144.635660930186;7954.482958607672;9568.234541236545;9970;10054.748631284276;10069.086873494012;10185.84721229197;10340.948295258475;10447.68656940293;10473.738156546147;10508.527116279633;9669.854952175863;9907.356021858845;9923.1069203772;9986.700398988041;10278.434686092336;7661.961690191513;7839;7915;7977.760667179994;8018.4787988780545;7700.19147989453;9200.447973121634;9296.814063718553;9463.810723785624;9537.427754334762 02:15:09 INFO - PROCESS | 10917 | |3;mootools.html;1147.179766466976;1380.4616199682125;1407.0994563479373;1486.7621180611104;1651.5128037229008;6818.488613353999;7360.631968401579;7623.885641715378;7640.694372225118;7801.92198078019;7856.8035799105055;8007.079185893624;8031.558264295461;8046.114927357986;8051.074126475457;1933.419974007799;1989.4827344890361;1994.3518356534184;2224.655178447335;2253.5380247049316;1971.2804826238391;2160.79472450117;2235.564065007316;2237.944051398712;2257.503349263168;2217.190725385231;2231.5983123037845;2234.0505285253785;2240.932772016842;2242.495438526335;1848.8428483578912;2162.4377661807966;2170.945726356838;2171.424572488276;2175.1734340950416;2145.495808485005;2214.645656694921;2214.9335519934266;2230.832687548424;2232.2075663139676;8041.477303975223;8082.232187942195;8097.35221182304;8098.75703728889;8100.068492123422;4549.6360291176625;4683.274092515666;4693.014466961942;4695.60087392572;4696.788644511005;2862.2844288927768;2968.1392396205074;3006.338605506785;3022.1386904732267;3046.57347971282;898.3172788680649;911.8085202107566;933.3093510801957;936.3960245641591;939.4504215034214;10903.727406814893;11057.557697692164;11063.502142403611;11100.722481937935;11132.332060076422;4106.815193316308;4301.41930839339;4317.697761156689;4382.824687012484;4385.605295523418;9305.069493050776;9306.488143152192;9312.674056407994;9328.160465558132;9336.439813611205;4504.301833215857;4506.278995360726;4512.368268442421;4517.661175411858;4519.141363140992;3514;3648.85404583819;4080.8775736727944;4133.8966525837095;4135.338345864648;3760.1351689111657;3778.3387907116144;3842.9423558646645;3855.8264878079995;3859.9035024124623;1202.9699257518457;1212.2847519963263;1217.190568272107;1218.9024878009739;1224.9571265005682;679.2833560593523;681.9965900170566;682.7269092363094;684.1040275630337;685.8456847209338;4876.219804831281;4969.776360063805;4985;5016.147254966664;5093.337866077461;407.7920260667022;412.7172886572647;422.4381572508556;427.0476836654278;429.2466720904792;3543.6633519815578;3617.2584620152807;3627.548980407858;3641.7997010164695;3670.926581468356;9499.810003799885;9890.950545247228;9899.109080182818;9906.55420506079;9930.652427165014;9674.371165874196;9812.067853553901;9839.55721992512;9844.950775246078;9845.45849978258;7480.251974802476;7551.320381165721;7562.168161502231;7569.5079819811535;7572.507786993938;4855.1260773061185;4896.094222568836;5004.124278251365;5040.36995375578;5063.113955057776;8884.644614215618;8965.686200982935;8988.325875559229;9103.135202155785;9122.863157052781;9085.13691199335;9283.675071372469;9389.953050234704;9460.101290377403;9462.290328225274;6038.305594856648;6578.967105164444;6708.771089626423;6779.89830152558;6795.864082718417;7739.458237923516;7769.572673503011;7774.844503109793;7845.882311765214;7855.764327070197;6711.765088221889;6856.554323968926;6888.138982627172;6950.930490695028;6985.1967023790885;6715.731370745311;6735.494837887276;6739.326067393417;6829.043933849364;6849;6250.343713909974;6289.811305660837;6327.778527751507;6350.396712312323;6368.0766288886925;4413.470383553994;4453.665975051949;4455.532169122195;4536.56902594253;4547.8635640930825;4470.307102399133;4476.306172543261;4526.253168227206;4547.272436410159;4662.813487460599 02:15:09 INFO - PROCESS | 10917 | |4;prototype.html;289.14557482638804;296.3125548726953;307.3438209422882;312.04514186589023;313.2075848104295;4851.345068415762;4893.1436998525205;4900.436449808273;4902.583280421164;4919.458859525449;4742.6205903527725;4792.90414191716;4827.5172482751705;4856.56731264277;4859.878503037426;3616.801075940829;3663.5420572428447;3732.533433320835;3762.3039737648487;3816.790076545789;3759.718021148411;3761.924761504782;3776.5090538229992;3795;3819.675327597158;3601.5137956375947;3729.347364211266;3755.530558680165;3764.9435258471144;3765.20930604572;3667.2482141161;3775.924481510382;3785.5583148868827;3810.571035861552;3821.617838216156;3374.240795820945;3375.544301519288;3377.1219482934366;3378.9187460012804;3402.1834759657504;4699.412573428322;4731.810727570893;4731.976340118312;4735.881602959919;4793.760311984422;4227.936580951288;4328.891777705551;4338.43600331958;4348.456442944632;4367.235733746614;4938.530839570235;4941.555260026615;5008.69947803133;5011.318944364747;5033.597312215014;3687.631236876318;3691.8338674759702;3692.058525076115;3702.1670124222105;3713.4032366082574;5068.276785892815;5181.1969144782615;5204.635675502755;5260.421353651095;5268.841934741964;3736.2153947671295;3738.1776009277914;3741.7193710471824;3746.6066063062985;3766.3408903441787;3812.390017597171;3828.1195325075387;3834.8466061357235;3838.0788610733225;3844.308024555551;4308.763018034038;4310.8360742599325;4311.267084595626;4316.805743741539;4321.092570560218;4814.831480898151;4974.626902982219;4989.600831933437;4997.775100120503;5007.59635375022;1288.1305119044607;1298.3508245877063;1308.2739079810797;1308.9672758180932;1316.7300703355788;848.4697064334791;857.6612238166015;897.9326550508738;904.7783293093235;913.954302284883;4459.175052615212;4465.776711164429;4486.214912390318;4494.348319493721;4496.797644106023;5183.585313174937;5200.453952335026;5202.531772140525;5228.764705588258;5261.815836445706;4304.870853874389;4440.777961101932;4488.618467430239;4499.0776890737325;4552.521985191574;2790.260580946051;2792.6229958955687;2795.4548862971933;2805.551111822099;2815.4650616382824;4808.158572249842;4852.223644216979;4882.292067650242;4898.779554920037;4901.681390709592;5098;5338.6529875558745;5340.385855626652;5389.353277606712;5400.594955378362;4915.729634870117;4959.305697202322;4960.627952903546;4963.255511673206;4967.70193788381;5256.421793602777;5278.313819203632;5279.894402112013;5285.894282114413;5291.285676433632;4837.37114175155;5190.767969773034;5193.61047921415;5196.53231209193;5206.687598744087;4919.704817710805;4964.180910149929;4967.552920237196;4971.130052240916;4980.128477516348;3754.7934863581672;3766.4350347448103;3766.7551609145316;3781.111438811822;3786.1481166737262;5014.617266272878;5186.948130518646;5196.194589838581;5197.688138711689;5360.946390536201;4995.775190116527;5016.172331565251;5030.647854650139;5033.823816166417;5048.5203905628905;5038.269450929668;5068.543831055223;5078.7206703631655;5089.51649593288;5119.539241468136;4757.3577567028005;4785.688930219525;5025.949740502549;5037.513933389732;5041.395032596112;5000.599832047033;5123.180291153398;5124.8206312778875;5128.282040514406;5135.409427915837;4994.101061808909;4997.675151115312;5013.498650134958;5026.145555255688;5037.874053148701 02:15:09 INFO - PROCESS | 10917 | |5;yui.html;619.9566030377872;629.2511910826119;645.3353046362248;646.6152639179693;783.690442275301;12352.629421117359;12770.553030643929;13203.075784695064;13214.801777973338;13289.136206146593;12558.120931534773;12582.307973061477;12675.873241267585;12680.11239213253;12702.23786572804;609.8201030695933;776.7941495503682;776.8873513340562;787.818801675615;790.5572879187673;795.6379847169524;797.9162187970267;807.9030516338048;808.7775861638038;808.8948436703221;839.492107275099;846.3652260804397;850.8893843800297;852.411835833273;852.8209076094028;657.81252343082;807.6648191000728;832.134580036761;844.6072576252042;845.5814371885895;608.5253502268238;609.3449541742644;609.5854818723267;609.689058580123;609.7195290166529;12709;12755.362231888368;12757.234565926074;12766.489340426371;12779.361031948365;12671.429785659668;13341.01485480431;13346.199228046251;13347;13686.110402823784;9515.524223788852;9760.560774765081;9869.555869985796;10234.33476824004;10335.431551264677;3260.836958152083;3363.9831800841084;3364.142143753352;3468.236987862666;3490.2844916791996;57830.42169578293;58001.839963200924;58441;58676.70661646707;59658.40341596615;10342.482875856178;10361.792764144826;10418.843717344245;10513.158947284199;10608;18363.63272734538;18399.908000459913;18404.447866564024;18407.079646017646;18416.539586510444;6607.80176594703;6667.966660166668;6773.259848139462;6904.654767261617;6908.689108990107;3723.702103831687;3782.1868298315994;3821.082940094357;3845.788481633481;3870.574236833946;2920.751736102455;3030.9997700758695;3035.7267845893975;3038.9392212155635;3041.650210225808;517.1260569637301;520.258631450182;520.5263210478522;531.4446403508343;538.2437675066537;538.2410800770895;545.3646501825408;550.033200202175;578.3522454850511;581.4214856218006;7850.921490785133;7866.292033716993;7956.641951112214;7982.281594656509;8135.983002124734;548.4953842464942;550.8237364043467;551.2613098448098;556.4852511426914;572.9140628905615;3742.4573436852047;3775.962240377616;3830.7649645446218;4060.573639767782;4112;89412.5529372349;90730;91775.24674259782;93119;94215.52892235495;76004.61997690087;78362;78618;79322.6033869827;79720.20279797244;45328.54671453309;45428.77285613551;45622.54377456183;65652.67173664102;70599.64700176568;7637;7652;7709.807254818675;7761.0298712660915;7868.173841746534;44115.338269925334;44665.55334446744;45471.77264113658;46466.07067858691;46853.53146468628;56816;62011;64099.35900640934;64451;64921.970457050644;9842.557084931052;9878.50607469638;9924.15644670211;10091.243156763125;10518.737031574272;10760.730981725519;10800.405977671304;10835.458227088771;10938.890611093788;11079.667609971713;9733.853992189981;10085.546150423395;10163.593456261668;10425;10610.098141658045;11843.58547450835;11902.107341949215;12192.146549741434;12209.145359824726;12885.42015609281;11331.773364532499;11597.710057248636;11842.348670823187;11996.64010079699;12138.150329476852;9356.391834530734;9876.85184722244;9982.900170998197;10068.597256109673;10277.756981358149;8670.739877803677;8726.869096963424;8965.417247878868;9009.864852027356;9544.761380965532 02:15:09 INFO - PROCESS | 10917 | __end_tp_report 02:15:09 INFO - PROCESS | 10917 | __start_cc_report 02:15:09 INFO - PROCESS | 10917 | _x_x_mozilla_cycle_collect,1000 02:15:09 INFO - PROCESS | 10917 | __end_cc_report 02:15:09 INFO - PROCESS | 10917 | __startTimestamp1467018909893__endTimestamp 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | ------- Summary: start ------- 02:15:09 INFO - PROCESS | 10917 | Number of tests: 6 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#0] dojo.html Cycles:165 Average:4724.68 Median:4840.44 stddev:494.07 (10.2%) stddev-sans-first:467.23 02:15:09 INFO - PROCESS | 10917 | Values: 2621.6 2656.2 2685.9 2703.2 2703.6 4712.5 4770.3 4796.8 4843.1 4882.1 4781.9 4829.9 4848.5 4848.7 4914.7 4350.9 4367.5 4369.5 4421.9 4489.7 4466.2 4483.1 4525.3 4540.2 4543.9 4314.9 4389.6 4444.9 4449.0 4529.8 4310.3 4317.5 4333.5 4339.9 4396.4 4341.6 4360.1 4361.0 4372.6 4403.5 4613.4 4714.7 4720.4 4733.3 4769.9 5112.7 5177.9 5191.2 5200.4 5204.3 5155.1 5200.9 5223.6 5237.1 5237.8 4711.4 4723.1 4751.6 4864.5 4865.7 5207.5 5259.7 5266.0 5269.7 5285.5 4980.8 4987.0 5045.5 5045.6 5047.8 4942.8 5030.9 5033.8 5049.1 5063.8 5044.9 5068.2 5082.4 5093.9 5146.0 5057.1 5067.3 5067.4 5072.0 5074.1 4232.5 4256.9 4296.7 4317.0 4330.4 3774.8 3783.5 3785.1 3803.2 3822.5 4401.7 4415.2 4417.5 4422.8 4461.4 4588.9 5029.1 5057.4 5095.3 5129.3 4414.9 4422.1 4425.2 4432.6 4450.3 4618.0 4631.7 4637.6 4666.1 4689.2 4723.2 4787.7 4788.0 4801.7 4832.8 5022.0 5091.0 5112.9 5179.7 5185.2 4783.0 4795.6 4799.5 4805.3 4844.1 5049.0 5052.7 5055.3 5060.5 5085.8 4901.9 5077.5 5115.1 5137.8 5158.5 5007.5 5021.9 5027.0 5028.2 5058.1 4838.7 5003.7 5010.5 5018.4 5025.4 4840.4 4901.9 4906.2 4967.0 4977.3 5020.0 5022.3 5027.7 5028.2 5069.5 4785.2 4812.5 4828.7 4884.6 4886.3 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#1] ext.html Cycles:180 Average:47266.92 Median:35190.97 stddev:88571.32 (251.7%) stddev-sans-first:88750.35 02:15:09 INFO - PROCESS | 10917 | Values: 555.6 580.7 586.6 587.4 589.1 26849.6 29267.6 29316.7 29331.9 29345.6 29212.3 45238.0 46522.3 46619.1 46624.5 7913.3 8026.6 8037.2 8038.1 8042.8 7938.7 8025.4 8030.5 8032.3 8032.6 8011.2 8023.4 8043.5 8044.1 8044.3 7881.6 7944.5 7952.8 7953.3 7958.2 7847.9 7981.1 7997.6 7998.1 8000.4 38734.8 38966.2 39045.8 39049.6 39061.4 2974.2 3089.1 3090.3 3116.5 3136.7 30029.8 30347.0 30356.2 30750.4 30854.4 3356.1 3356.7 3374.3 3393.9 3400.2 262330.0 262359.0 262568.0 262731.0 263676.0 31970.8 33101.2 33171.5 53387.0 53953.2 34126.7 34154.0 34212.5 34332.0 34335.7 12263.4 12318.3 12325.2 12341.6 12342.1 10885.3 10963.5 10975.3 10976.6 10979.2 7784.6 7860.0 7893.3 7936.4 7947.5 3077.8 3078.7 3101.5 3128.9 3150.4 793.6 837.8 844.5 853.8 917.2 28273.9 28397.0 28538.3 29038.7 29210.9 745.5 889.5 905.9 931.2 956.4 14392.2 14615.6 14858.2 15076.7 15109.8 391057.0 394951.0 395046.0 395378.0 396302.0 49715.3 50933.0 50998.7 51044.0 51197.2 1027.2 1077.7 1084.4 1139.7 1146.7 24389.5 31504.0 31522.5 31993.8 32226.7 47003.5 47816.5 47819.3 48187.8 48581.3 333442.0 334729.0 336745.0 336806.0 336905.0 25010.6 25656.2 26023.5 26048.5 26053.3 42130.6 43254.6 43508.6 44353.3 44678.6 36446.3 37567.8 37653.2 37849.8 37903.0 36720.4 36894.6 37009.4 37215.3 37644.6 28538.9 31617.0 36046.3 36197.5 37706.4 31088.0 32764.7 32898.7 33166.8 33244.8 24496.9 24649.6 24922.8 25258.0 25622.6 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#2] jquery.html Cycles:180 Average:23605.39 Median:27293.38 stddev:64307.49 (235.6%) stddev-sans-first:64464.22 02:15:09 INFO - PROCESS | 10917 | Values: 368.1 375.7 377.7 381.0 385.9 16098.3 17308.0 17396.9 17623.2 17648.8 11948.4 15474.2 16273.3 16329.9 16893.7 4489.5 4682.9 4715.2 4715.9 4721.6 3518.5 3711.8 4659.1 5379.4 5682.1 5728.1 5737.7 5761.5 5767.4 5768.6 5297.7 5303.5 5309.1 5312.4 5493.9 3435.8 5148.8 5176.0 5471.7 5477.4 12565.9 12786.9 12794.6 12854.8 12867.2 1813.8 1831.6 1834.8 2006.2 2272.3 8281.4 8603.2 9022.0 9035.1 9048.1 1611.9 1674.6 1696.4 1731.8 1736.7 59509.7 61596.7 66976.7 67476.3 67535.3 9934.8 9940.5 10011.2 10109.7 10317.9 14141.5 14179.4 14212.1 14216.9 14225.6 6879.5 7002.4 7078.1 7157.5 7426.7 6391.6 6534.9 6564.6 6690.0 6713.6 4471.1 4485.8 4517.2 4523.8 4600.4 1727.3 1806.5 1810.3 1815.3 1829.2 694.0 741.4 780.7 838.1 900.5 16336.3 16382.4 16482.7 16825.8 17292.8 793.3 797.6 800.3 833.4 841.0 9110.1 9366.5 9656.9 9666.0 9778.1 384514.0 388295.8 390087.0 394388.0 394933.0 49438.0 56485.0 75519.6 78964.0 79265.8 876.8 919.2 955.4 961.2 965.5 15660.2 15752.2 15884.5 15997.8 16073.5 36455.8 36503.0 37177.4 37414.4 38093.0 47192.1 52608.0 52803.5 53470.2 54984.9 6522.2 7127.8 7185.0 7364.1 7408.5 9264.3 11410.6 11511.1 11697.8 12144.6 7954.5 9568.2 9970.0 10054.7 10069.1 10185.8 10340.9 10447.7 10473.7 10508.5 9669.9 9907.4 9923.1 9986.7 10278.4 7662.0 7839.0 7915.0 7977.8 8018.5 7700.2 9200.4 9296.8 9463.8 9537.4 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#3] mootools.html Cycles:180 Average:5166.76 Median:4865.67 stddev:2986.88 (61.4%) stddev-sans-first:2979.98 02:15:09 INFO - PROCESS | 10917 | Values: 1147.2 1380.5 1407.1 1486.8 1651.5 6818.5 7360.6 7623.9 7640.7 7801.9 7856.8 8007.1 8031.6 8046.1 8051.1 1933.4 1989.5 1994.4 2224.7 2253.5 1971.3 2160.8 2235.6 2237.9 2257.5 2217.2 2231.6 2234.1 2240.9 2242.5 1848.8 2162.4 2170.9 2171.4 2175.2 2145.5 2214.6 2214.9 2230.8 2232.2 8041.5 8082.2 8097.4 8098.8 8100.1 4549.6 4683.3 4693.0 4695.6 4696.8 2862.3 2968.1 3006.3 3022.1 3046.6 898.3 911.8 933.3 936.4 939.5 10903.7 11057.6 11063.5 11100.7 11132.3 4106.8 4301.4 4317.7 4382.8 4385.6 9305.1 9306.5 9312.7 9328.2 9336.4 4504.3 4506.3 4512.4 4517.7 4519.1 3514.0 3648.9 4080.9 4133.9 4135.3 3760.1 3778.3 3842.9 3855.8 3859.9 1203.0 1212.3 1217.2 1218.9 1225.0 679.3 682.0 682.7 684.1 685.8 4876.2 4969.8 4985.0 5016.1 5093.3 407.8 412.7 422.4 427.0 429.2 3543.7 3617.3 3627.5 3641.8 3670.9 9499.8 9891.0 9899.1 9906.6 9930.7 9674.4 9812.1 9839.6 9845.0 9845.5 7480.3 7551.3 7562.2 7569.5 7572.5 4855.1 4896.1 5004.1 5040.4 5063.1 8884.6 8965.7 8988.3 9103.1 9122.9 9085.1 9283.7 9390.0 9460.1 9462.3 6038.3 6579.0 6708.8 6779.9 6795.9 7739.5 7769.6 7774.8 7845.9 7855.8 6711.8 6856.6 6888.1 6950.9 6985.2 6715.7 6735.5 6739.3 6829.0 6849.0 6250.3 6289.8 6327.8 6350.4 6368.1 4413.5 4453.7 4455.5 4536.6 4547.9 4470.3 4476.3 4526.3 4547.3 4662.8 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#4] prototype.html Cycles:180 Average:4220.38 Median:4821.17 stddev:1213.44 (25.2%) stddev-sans-first:1180.42 02:15:09 INFO - PROCESS | 10917 | Values: 289.1 296.3 307.3 312.0 313.2 4851.3 4893.1 4900.4 4902.6 4919.5 4742.6 4792.9 4827.5 4856.6 4859.9 3616.8 3663.5 3732.5 3762.3 3816.8 3759.7 3761.9 3776.5 3795.0 3819.7 3601.5 3729.3 3755.5 3764.9 3765.2 3667.2 3775.9 3785.6 3810.6 3821.6 3374.2 3375.5 3377.1 3378.9 3402.2 4699.4 4731.8 4732.0 4735.9 4793.8 4227.9 4328.9 4338.4 4348.5 4367.2 4938.5 4941.6 5008.7 5011.3 5033.6 3687.6 3691.8 3692.1 3702.2 3713.4 5068.3 5181.2 5204.6 5260.4 5268.8 3736.2 3738.2 3741.7 3746.6 3766.3 3812.4 3828.1 3834.8 3838.1 3844.3 4308.8 4310.8 4311.3 4316.8 4321.1 4814.8 4974.6 4989.6 4997.8 5007.6 1288.1 1298.4 1308.3 1309.0 1316.7 848.5 857.7 897.9 904.8 914.0 4459.2 4465.8 4486.2 4494.3 4496.8 5183.6 5200.5 5202.5 5228.8 5261.8 4304.9 4440.8 4488.6 4499.1 4552.5 2790.3 2792.6 2795.5 2805.6 2815.5 4808.2 4852.2 4882.3 4898.8 4901.7 5098.0 5338.7 5340.4 5389.4 5400.6 4915.7 4959.3 4960.6 4963.3 4967.7 5256.4 5278.3 5279.9 5285.9 5291.3 4837.4 5190.8 5193.6 5196.5 5206.7 4919.7 4964.2 4967.6 4971.1 4980.1 3754.8 3766.4 3766.8 3781.1 3786.1 5014.6 5186.9 5196.2 5197.7 5360.9 4995.8 5016.2 5030.6 5033.8 5048.5 5038.3 5068.5 5078.7 5089.5 5119.5 4757.4 4785.7 5025.9 5037.5 5041.4 5000.6 5123.2 5124.8 5128.3 5135.4 4994.1 4997.7 5013.5 5026.1 5037.9 02:15:09 INFO - PROCESS | 10917 | 02:15:09 INFO - PROCESS | 10917 | [#5] yui.html Cycles:180 Average:16622.59 Median:549.26 stddev:23264.59 (4235.6%) stddev-sans-first:23298.83 02:15:09 INFO - PROCESS | 10917 | Values: 620.0 629.3 645.3 646.6 783.7 12352.6 12770.6 13203.1 13214.8 13289.1 12558.1 12582.3 12675.9 12680.1 12702.2 609.8 776.8 776.9 787.8 790.6 795.6 797.9 807.9 808.8 808.9 839.5 846.4 850.9 852.4 852.8 657.8 807.7 832.1 844.6 845.6 608.5 609.3 609.6 609.7 609.7 12709.0 12755.4 12757.2 12766.5 12779.4 12671.4 13341.0 13346.2 13347.0 13686.1 9515.5 9760.6 9869.6 10234.3 10335.4 3260.8 3364.0 3364.1 3468.2 3490.3 57830.4 58001.8 58441.0 58676.7 59658.4 10342.5 10361.8 10418.8 10513.2 10608.0 18363.6 18399.9 18404.4 18407.1 18416.5 6607.8 6668.0 6773.3 6904.7 6908.7 3723.7 3782.2 3821.1 3845.8 3870.6 2920.8 3031.0 3035.7 3038.9 3041.7 517.1 520.3 520.5 531.4 538.2 538.2 545.4 550.0 578.4 581.4 7850.9 7866.3 7956.6 7982.3 8136.0 548.5 550.8 551.3 556.5 572.9 3742.5 3776.0 3830.8 4060.6 4112.0 89412.6 90730.0 91775.2 93119.0 94215.5 76004.6 78362.0 78618.0 79322.6 79720.2 45328.5 45428.8 45622.5 65652.7 70599.6 7637.0 7652.0 7709.8 7761.0 7868.2 44115.3 44665.6 45471.8 46466.1 46853.5 56816.0 62011.0 64099.4 64451.0 64922.0 9842.6 9878.5 9924.2 10091.2 10518.7 10760.7 10800.4 10835.5 10938.9 11079.7 9733.9 10085.5 10163.6 10425.0 10610.1 11843.6 11902.1 12192.1 12209.1 12885.4 11331.8 11597.7 11842.3 11996.6 12138.2 9356.4 9876.9 9982.9 10068.6 10277.8 8670.7 8726.9 8965.4 9009.9 9544.8 02:15:09 INFO - PROCESS | 10917 | -------- Summary: end -------- 02:15:09 INFO - PROCESS | 10917 | 02:15:10 INFO - TEST-INFO | 10917: exit 0 02:15:10 INFO - TEST-OK | dromaeo_css | took 1121096ms 02:15:10 INFO - TEST-START | kraken 02:15:10 INFO - operating with platform_type : linux_ 02:15:10 INFO - Initialising browser for kraken test... 02:15:10 INFO - TEST-INFO | started process 11099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4M1W8/profile http://localhost:49014/getInfo.html) 02:15:15 INFO - PROCESS | 11099 | __metrics Screen width/height:1600/1200 02:15:15 INFO - PROCESS | 11099 | colorDepth:24 02:15:15 INFO - PROCESS | 11099 | Browser inner width/height: 1024/697 02:15:15 INFO - PROCESS | 11099 | __metrics 02:15:16 INFO - PROCESS | 11099 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:15:17 INFO - TEST-INFO | 11099: exit 0 02:15:17 INFO - Browser initialized. 02:15:17 INFO - Running cycle 1/1 for kraken test... 02:15:17 INFO - TEST-INFO | started process 11179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4M1W8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:29 INFO - PROCESS | 11179 | RSS: Main: 175300608 02:15:29 INFO - PROCESS | 11179 | 02:15:32 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49014/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:33 INFO - PROCESS | 11179 | RSS: Main: 233164800 02:15:33 INFO - PROCESS | 11179 | 02:15:35 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49014/tests/kraken/driver.html?testName=audio-dft) 02:15:36 INFO - PROCESS | 11179 | RSS: Main: 221159424 02:15:36 INFO - PROCESS | 11179 | 02:15:39 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49014/tests/kraken/driver.html?testName=audio-fft) 02:15:40 INFO - PROCESS | 11179 | RSS: Main: 287776768 02:15:40 INFO - PROCESS | 11179 | 02:15:42 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49014/tests/kraken/driver.html?testName=audio-oscillator) 02:15:43 INFO - PROCESS | 11179 | RSS: Main: 198238208 02:15:43 INFO - PROCESS | 11179 | 02:15:45 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:46 INFO - PROCESS | 11179 | RSS: Main: 201641984 02:15:46 INFO - PROCESS | 11179 | 02:15:49 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49014/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:49 INFO - PROCESS | 11179 | RSS: Main: 237854720 02:15:49 INFO - PROCESS | 11179 | 02:15:53 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49014/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:53 INFO - PROCESS | 11179 | RSS: Main: 238469120 02:15:53 INFO - PROCESS | 11179 | 02:15:56 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49014/tests/kraken/driver.html?testName=json-parse-financial) 02:15:57 INFO - PROCESS | 11179 | RSS: Main: 238518272 02:15:57 INFO - PROCESS | 11179 | 02:15:59 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:59 INFO - PROCESS | 11179 | RSS: Main: 227713024 02:15:59 INFO - PROCESS | 11179 | 02:16:01 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:16:02 INFO - PROCESS | 11179 | RSS: Main: 231792640 02:16:02 INFO - PROCESS | 11179 | 02:16:04 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:16:05 INFO - PROCESS | 11179 | RSS: Main: 237326336 02:16:05 INFO - PROCESS | 11179 | 02:16:07 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:16:08 INFO - PROCESS | 11179 | RSS: Main: 240058368 02:16:08 INFO - PROCESS | 11179 | 02:16:11 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:16:11 INFO - PROCESS | 11179 | RSS: Main: 238444544 02:16:11 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | Cycle 1(1): loaded http://localhost:49014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49014/tests/kraken/driver.html?testName=ai-astar) 02:16:13 INFO - PROCESS | 11179 | RSS: Main: 280645632 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | __start_tp_report 02:16:13 INFO - PROCESS | 11179 | _x_x_mozilla_page_load 02:16:13 INFO - PROCESS | 11179 | _x_x_mozilla_page_load_details 02:16:13 INFO - PROCESS | 11179 | |i|pagename|runs| 02:16:13 INFO - PROCESS | 11179 | |0;ai-astar;103;113;112;113;113;111;111;116;115;113 02:16:13 INFO - PROCESS | 11179 | |1;audio-beat-detection;169;130;131;190;133;133;152;132;162;130 02:16:13 INFO - PROCESS | 11179 | |2;audio-dft;162;162;162;162;159;162;161;160;163;159 02:16:13 INFO - PROCESS | 11179 | |3;audio-fft;77;75;78;115;77;77;75;77;102;76 02:16:13 INFO - PROCESS | 11179 | |4;audio-oscillator;87;86;116;85;85;86;122;86;85;129 02:16:13 INFO - PROCESS | 11179 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;117;117 02:16:13 INFO - PROCESS | 11179 | |6;imaging-darkroom;146;147;146;146;145;147;146;146;146;146 02:16:13 INFO - PROCESS | 11179 | |7;imaging-desaturate;95;95;95;95;95;95;94;94;96;95 02:16:13 INFO - PROCESS | 11179 | |8;json-parse-financial;64;65;62;63;63;64;66;63;64;64 02:16:13 INFO - PROCESS | 11179 | |9;json-stringify-tinderbox;66;66;65;65;65;65;65;66;65;66 02:16:13 INFO - PROCESS | 11179 | |10;stanford-crypto-aes;86;82;87;82;86;84;88;84;115;82 02:16:13 INFO - PROCESS | 11179 | |11;stanford-crypto-ccm;132;134;139;128;129;131;128;130;132;134 02:16:13 INFO - PROCESS | 11179 | |12;stanford-crypto-pbkdf2;170;171;172;175;172;173;172;169;172;174 02:16:13 INFO - PROCESS | 11179 | |13;stanford-crypto-sha256-iterative;68;67;67;67;67;68;70;68;66;65 02:16:13 INFO - PROCESS | 11179 | __end_tp_report 02:16:13 INFO - PROCESS | 11179 | __start_cc_report 02:16:13 INFO - PROCESS | 11179 | _x_x_mozilla_cycle_collect,1893 02:16:13 INFO - PROCESS | 11179 | __end_cc_report 02:16:13 INFO - PROCESS | 11179 | __startTimestamp1467018973896__endTimestamp 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | ------- Summary: start ------- 02:16:13 INFO - PROCESS | 11179 | Number of tests: 14 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.53 (3.1%) stddev-sans-first:1.66 02:16:13 INFO - PROCESS | 11179 | Values: 103.0 113.0 112.0 113.0 113.0 111.0 111.0 116.0 115.0 113.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:142.50 stddev:21.15 (14.8%) stddev-sans-first:20.77 02:16:13 INFO - PROCESS | 11179 | Values: 169.0 130.0 131.0 190.0 133.0 133.0 152.0 132.0 162.0 130.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 02:16:13 INFO - PROCESS | 11179 | Values: 162.0 162.0 162.0 162.0 159.0 162.0 161.0 160.0 163.0 159.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.87 (18.0%) stddev-sans-first:14.54 02:16:13 INFO - PROCESS | 11179 | Values: 77.0 75.0 78.0 115.0 77.0 77.0 75.0 77.0 102.0 76.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.50 stddev:17.96 (21.0%) stddev-sans-first:18.71 02:16:13 INFO - PROCESS | 11179 | Values: 87.0 86.0 116.0 85.0 85.0 86.0 122.0 86.0 85.0 129.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:16:13 INFO - PROCESS | 11179 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:16:13 INFO - PROCESS | 11179 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:16:13 INFO - PROCESS | 11179 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 96.0 95.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 02:16:13 INFO - PROCESS | 11179 | Values: 64.0 65.0 62.0 63.0 63.0 64.0 66.0 63.0 64.0 64.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 02:16:13 INFO - PROCESS | 11179 | Values: 66.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.00 stddev:9.87 (11.6%) stddev-sans-first:10.45 02:16:13 INFO - PROCESS | 11179 | Values: 86.0 82.0 87.0 82.0 86.0 84.0 88.0 84.0 115.0 82.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:132.00 stddev:3.37 (2.6%) stddev-sans-first:3.57 02:16:13 INFO - PROCESS | 11179 | Values: 132.0 134.0 139.0 128.0 129.0 131.0 128.0 130.0 132.0 134.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:1.76 (1.0%) stddev-sans-first:1.72 02:16:13 INFO - PROCESS | 11179 | Values: 170.0 171.0 172.0 175.0 172.0 173.0 172.0 169.0 172.0 174.0 02:16:13 INFO - PROCESS | 11179 | 02:16:13 INFO - PROCESS | 11179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.34 (2.0%) stddev-sans-first:1.39 02:16:13 INFO - PROCESS | 11179 | Values: 68.0 67.0 67.0 67.0 67.0 68.0 70.0 68.0 66.0 65.0 02:16:13 INFO - PROCESS | 11179 | -------- Summary: end -------- 02:16:13 INFO - PROCESS | 11179 | 02:16:14 INFO - TEST-INFO | 11179: exit 0 02:16:14 INFO - TEST-OK | kraken | took 64219ms 02:16:14 INFO - SUITE-END | took 1185s 02:16:15 INFO - Completed test suite (00:19:45) 02:16:15 INFO - javascript benchmark 02:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.5936529837873, 2656.203139058282, 2685.8657067146646, 2703.2025552462023, 2703.6350092737475, 4712.505186955364, 4770.3083052957345, 4796.760161991895, 4843.055604157186, 4882.072406242812, 4781.90436191276, 4829.927551086727, 4848.490908454614, 4848.684835485691, 4914.729689867056, 4350.934735978947, 4367.475902891658, 4369.4756629204385, 4421.9336709949375, 4489.708168969023, 4466.218411777926, 4483.08096840147, 4525.2533332000185, 4540.2054640437955, 4543.932175938652, 4314.935275970863, 4389.561043895616, 4444.888877778049, 4449.0, 4529.750863702495, 4310.31035034393, 4317.481902171759, 4333.501647310537, 4339.891502712426, 4396.428464299621, 4341.587549182823, 4360.106178233455, 4361.040571074359, 4372.6064654180955, 4403.493598236212, 4613.423322084739, 4714.669973101884, 4720.3863497745415, 4733.337332773414, 4769.928451073237, 5112.667676601009, 5177.948220517822, 5191.169412893956, 5200.427952925175, 5204.34945631796, 5155.072087024334, 5200.869978250536, 5223.6343455958095, 5237.109691352441, 5237.8428647140645, 4711.387519622427, 4723.102610503994, 4751.596114330251, 4864.513548645107, 4865.7323847188745, 5207.453217412117, 5259.737013149327, 5266.0, 5269.71016594091, 5285.497877701612, 4980.775865086008, 4987.0, 5045.47022562633, 5045.646804723634, 5047.772850221749, 4942.802287908444, 5030.899382012412, 5033.84898453047, 5049.065922804293, 5063.772130254148, 5044.949550504448, 5068.214426763858, 5082.390113186441, 5093.898122037538, 5145.974270128625, 5057.115004874132, 5067.315912351785, 5067.366579177603, 5072.036313100499, 5074.112030394666, 4232.470941132358, 4256.91486170281, 4296.677749168824, 4317.007088369693, 4330.41539392178, 3774.75464094833, 3783.50814394127, 3785.072657199004, 3803.1823158021157, 3822.4648549203134, 4401.713888597231, 4415.161119387306, 4417.53615870329, 4422.84520041797, 4461.420015398043, 4588.931166032446, 5029.06962211992, 5057.418396884332, 5095.286659867622, 5129.333186685707, 4414.933775993362, 4422.137683151755, 4425.22558552252, 4432.578905004019, 4450.265706158512, 4618.03021365517, 4631.675782695179, 4637.605803506673, 4666.066786642753, 4689.20283551797, 4723.173444647242, 4787.664863459524, 4788.04239152164, 4801.735904525145, 4832.758362081811, 5021.974890125526, 5091.0, 5112.872178195575, 5179.715115668524, 5185.196294574347, 4783.0, 4795.592374648055, 4799.544043315879, 4805.27920811881, 4844.103840789465, 5048.974755126201, 5052.69683818972, 5055.317532133115, 5060.51925067118, 5085.7711402986215, 4901.9019619608125, 5077.466865979019, 5115.130427827204, 5137.845864624067, 5158.45836187195, 5007.499250075109, 5021.874453138701, 5027.0, 5028.170351891897, 5058.1401161803315, 4838.7338696372035, 5003.724795136302, 5010.473900240422, 5018.42288136869, 5025.39695236574, 4840.443349014768, 4901.877453063702, 4906.21500559923, 4966.975165124151, 4977.303177555217, 5020.0, 5022.3219865317715, 5027.673201242053, 5028.170351892043, 5069.467705890828, 4785.186518291968, 4812.51874812516, 4828.7102773833685, 4884.584810291165, 4886.267059941038], "value": 4693.291758485845, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6253442461373, 580.7270582826071, 586.6069733278703, 587.362711458068, 589.1339730596023, 26849.597256041176, 29267.560986585217, 29316.706832931664, 29331.853340733265, 29345.559816602767, 29212.26969325768, 45238.0, 46522.30216546746, 46619.067618647605, 46624.53375466244, 7913.3273671737825, 8026.5986700664735, 8037.156098609649, 8038.115807261197, 8042.839143217132, 7938.682452701885, 8025.438219324649, 8030.5181689098545, 8032.3172530335, 8032.558209298486, 8011.158828323029, 8023.4383593148505, 8043.4771739837015, 8044.074931382878, 8044.316233120163, 7881.566513841736, 7944.483608565425, 7952.767321065216, 7953.2842044216295, 7958.164392738737, 7847.882281765778, 7981.082175549828, 7997.600119994036, 7998.080220774627, 8000.4399692021, 38734.80632596819, 38966.220675586614, 39045.80477097625, 39049.60950390488, 39061.41407878884, 2974.2118338640275, 3089.119600913729, 3090.3138225664884, 3116.501359782447, 3136.6863313668678, 30029.849850750605, 30347.0, 30356.24109397283, 30750.384992300027, 30854.38291234185, 3356.127406874206, 3356.7314614830757, 3374.325134972991, 3393.949090763616, 3400.2009527760956, 262330.0, 262359.0112790991, 262567.9999999981, 262731.0, 263676.0, 31970.84014579912, 33101.17247068843, 33171.50242746361, 53387.0, 53953.1907021395, 34126.65873341284, 34154.0, 34212.48681269783, 34332.0, 34335.656643433744, 12263.448144833505, 12318.260904345769, 12325.198862074116, 12341.62975110748, 12342.074344424203, 10885.346879187275, 10963.50664220112, 10975.341479511255, 10976.615818446317, 10979.17656175774, 7784.610769461618, 7859.960700196577, 7893.329067029367, 7936.444448888522, 7947.483413578215, 3077.7691673124605, 3078.6613472518006, 3101.5347697845505, 3128.89048883288, 3150.401423729484, 793.5595744361934, 837.8282452097305, 844.4511067805976, 853.8036251662028, 917.2157805076697, 28273.858630706716, 28397.0, 28538.286542836595, 29038.709612904022, 29210.853945730134, 745.4632664481672, 889.5241046040467, 905.9229965452879, 931.1573026411108, 956.3544607389983, 14392.20842853653, 14615.561533154023, 14858.182799946107, 15076.698466030617, 15109.773353399707, 391057.0, 394951.0, 395046.0, 395378.0, 396302.0, 49715.254271185964, 50933.0, 50998.74500627547, 51044.0, 51197.232041519404, 1027.157730660851, 1077.6605369308643, 1084.3927400655816, 1139.7492551638627, 1146.6502716671496, 24389.51220975535, 31504.0, 31522.527162093047, 31993.840030799696, 32226.67773322237, 47003.52996469991, 47816.521834781204, 47819.28271075867, 48187.759061204466, 48581.27128093152, 333442.0, 334729.0, 336745.0, 336806.0, 336905.0, 25010.62399072085, 25656.230313090637, 26023.479530408906, 26048.479030419665, 26053.348666283495, 42130.578694212665, 43254.56745432506, 43508.564914351715, 44353.33469997888, 44678.553214467436, 36446.27107457783, 37567.81216094011, 37653.2469350606, 37849.81075094607, 37903.0, 36720.449193262655, 36894.63105368912, 37009.44485832768, 37215.25569488541, 37644.62355376521, 28538.87265255151, 31617.0, 36046.27907441784, 36197.457038144974, 37706.43440348452, 31088.0, 32764.672353277114, 32898.67101328956, 33166.834165829016, 33244.83377583193, 24496.87751561231, 24649.630255545824, 24922.750772492043, 25258.0, 25622.61566076473], "value": 16385.018961138365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.1477379865612, 375.72008853404213, 377.712938166993, 380.96761775249104, 385.8591614060865, 16098.275577599006, 17308.0, 17396.913015434904, 17623.206955686994, 17648.82351176488, 11948.402579871015, 15474.22628868555, 16273.267702953366, 16329.918350408261, 16893.746593801105, 4489.5285994970545, 4682.90634187316, 4715.198416269225, 4715.929261061086, 4721.598664113537, 3518.542589463379, 3711.777293362407, 4659.068186362741, 5379.354477462691, 5682.147677848335, 5728.083506638938, 5737.741801618937, 5761.510271626917, 5767.394423585526, 5768.596198266123, 5297.682139071649, 5303.469653034705, 5309.123994540896, 5312.362516498007, 5493.890122197554, 3435.7766745161484, 5148.768305426265, 5176.016556854186, 5471.671699698031, 5477.370102438231, 12565.93717031409, 12786.936065319707, 12794.616161515169, 12854.807177892339, 12867.227966321958, 1813.8276863697927, 1831.615360774239, 1834.8440382567499, 2006.2175751456944, 2272.3296627494765, 8281.420300578962, 8603.182697643713, 9021.954890225572, 9035.051319611412, 9048.095190480964, 1611.8629916457114, 1674.6315810521667, 1696.355384953722, 1731.826817318258, 1736.722124460093, 59509.7024514879, 61596.69201653963, 66976.66511667459, 67476.32523674799, 67535.32464675339, 9934.80130397388, 9940.502974851228, 10011.199104071657, 10109.747256318651, 10317.9484102579, 14141.5050473235, 14179.361928713233, 14212.076215045989, 14216.928915355564, 14225.644358890904, 6879.484038697117, 7002.404795592432, 7078.115235595551, 7157.534760240567, 7426.665800039012, 6391.552591318563, 6534.869302613921, 6564.606123632598, 6689.966550167218, 6713.630750308682, 4471.083427897273, 4485.820567177341, 4517.164324599959, 4523.773811309487, 4600.42494688164, 1727.3263427263378, 1806.4941816291196, 1810.3120814090562, 1815.2648177488138, 1829.1768704083215, 693.9555968267724, 741.3809469093368, 780.7306479264645, 838.0571856661256, 900.4552245891141, 16336.264868080965, 16382.426615068416, 16482.670346593, 16825.831741682672, 17292.827071729374, 793.2701914238914, 797.6291024673554, 800.2757504458474, 833.3541505333416, 841.0454134557199, 9110.088991100969, 9366.531673416439, 9656.855147172799, 9665.951670241604, 9778.119969202806, 384514.0, 388295.7607755487, 390087.0, 394388.0, 394933.0, 49438.0, 56485.0, 75519.62240188764, 78964.0, 79265.81101283485, 876.8202518483696, 919.2140719684573, 955.4028732042474, 961.240619910263, 965.4882912056621, 15660.216989150726, 15752.212389380715, 15884.52346429609, 15997.760033599272, 16073.517794466185, 36455.81772091229, 36503.0, 37177.4423383644, 37414.438783417725, 38093.0, 47192.05615887732, 52608.0, 52803.511701505806, 53470.19794703005, 54984.90030199294, 6522.21733391996, 7127.75052873147, 7184.9640751795905, 7364.116306043309, 7408.518446300973, 9264.305177111608, 11410.600628977945, 11511.136664750346, 11697.824532631847, 12144.635660930186, 7954.482958607672, 9568.234541236545, 9970.0, 10054.748631284276, 10069.086873494012, 10185.84721229197, 10340.948295258475, 10447.68656940293, 10473.738156546147, 10508.527116279633, 9669.854952175863, 9907.356021858845, 9923.1069203772, 9986.700398988041, 10278.434686092336, 7661.961690191513, 7839.0, 7915.0, 7977.760667179994, 8018.4787988780545, 7700.19147989453, 9200.447973121634, 9296.814063718553, 9463.810723785624, 9537.427754334762], "value": 7876.935479319702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1147.179766466976, 1380.4616199682125, 1407.0994563479373, 1486.7621180611104, 1651.5128037229008, 6818.488613353999, 7360.631968401579, 7623.885641715378, 7640.694372225118, 7801.92198078019, 7856.8035799105055, 8007.079185893624, 8031.558264295461, 8046.114927357986, 8051.074126475457, 1933.419974007799, 1989.4827344890361, 1994.3518356534184, 2224.655178447335, 2253.5380247049316, 1971.2804826238391, 2160.79472450117, 2235.564065007316, 2237.944051398712, 2257.503349263168, 2217.190725385231, 2231.5983123037845, 2234.0505285253785, 2240.932772016842, 2242.495438526335, 1848.8428483578912, 2162.4377661807966, 2170.945726356838, 2171.424572488276, 2175.1734340950416, 2145.495808485005, 2214.645656694921, 2214.9335519934266, 2230.832687548424, 2232.2075663139676, 8041.477303975223, 8082.232187942195, 8097.35221182304, 8098.75703728889, 8100.068492123422, 4549.6360291176625, 4683.274092515666, 4693.014466961942, 4695.60087392572, 4696.788644511005, 2862.2844288927768, 2968.1392396205074, 3006.338605506785, 3022.1386904732267, 3046.57347971282, 898.3172788680649, 911.8085202107566, 933.3093510801957, 936.3960245641591, 939.4504215034214, 10903.727406814893, 11057.557697692164, 11063.502142403611, 11100.722481937935, 11132.332060076422, 4106.815193316308, 4301.41930839339, 4317.697761156689, 4382.824687012484, 4385.605295523418, 9305.069493050776, 9306.488143152192, 9312.674056407994, 9328.160465558132, 9336.439813611205, 4504.301833215857, 4506.278995360726, 4512.368268442421, 4517.661175411858, 4519.141363140992, 3514.0, 3648.85404583819, 4080.8775736727944, 4133.8966525837095, 4135.338345864648, 3760.1351689111657, 3778.3387907116144, 3842.9423558646645, 3855.8264878079995, 3859.9035024124623, 1202.9699257518457, 1212.2847519963263, 1217.190568272107, 1218.9024878009739, 1224.9571265005682, 679.2833560593523, 681.9965900170566, 682.7269092363094, 684.1040275630337, 685.8456847209338, 4876.219804831281, 4969.776360063805, 4985.0, 5016.147254966664, 5093.337866077461, 407.7920260667022, 412.7172886572647, 422.4381572508556, 427.0476836654278, 429.2466720904792, 3543.6633519815578, 3617.2584620152807, 3627.548980407858, 3641.7997010164695, 3670.926581468356, 9499.810003799885, 9890.950545247228, 9899.109080182818, 9906.55420506079, 9930.652427165014, 9674.371165874196, 9812.067853553901, 9839.55721992512, 9844.950775246078, 9845.45849978258, 7480.251974802476, 7551.320381165721, 7562.168161502231, 7569.5079819811535, 7572.507786993938, 4855.1260773061185, 4896.094222568836, 5004.124278251365, 5040.36995375578, 5063.113955057776, 8884.644614215618, 8965.686200982935, 8988.325875559229, 9103.135202155785, 9122.863157052781, 9085.13691199335, 9283.675071372469, 9389.953050234704, 9460.101290377403, 9462.290328225274, 6038.305594856648, 6578.967105164444, 6708.771089626423, 6779.89830152558, 6795.864082718417, 7739.458237923516, 7769.572673503011, 7774.844503109793, 7845.882311765214, 7855.764327070197, 6711.765088221889, 6856.554323968926, 6888.138982627172, 6950.930490695028, 6985.1967023790885, 6715.731370745311, 6735.494837887276, 6739.326067393417, 6829.043933849364, 6849.0, 6250.343713909974, 6289.811305660837, 6327.778527751507, 6350.396712312323, 6368.0766288886925, 4413.470383553994, 4453.665975051949, 4455.532169122195, 4536.56902594253, 4547.8635640930825, 4470.307102399133, 4476.306172543261, 4526.253168227206, 4547.272436410159, 4662.813487460599], "value": 4047.2805391408015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.14557482638804, 296.3125548726953, 307.3438209422882, 312.04514186589023, 313.2075848104295, 4851.345068415762, 4893.1436998525205, 4900.436449808273, 4902.583280421164, 4919.458859525449, 4742.6205903527725, 4792.90414191716, 4827.5172482751705, 4856.56731264277, 4859.878503037426, 3616.801075940829, 3663.5420572428447, 3732.533433320835, 3762.3039737648487, 3816.790076545789, 3759.718021148411, 3761.924761504782, 3776.5090538229992, 3795.0, 3819.675327597158, 3601.5137956375947, 3729.347364211266, 3755.530558680165, 3764.9435258471144, 3765.20930604572, 3667.2482141161, 3775.924481510382, 3785.5583148868827, 3810.571035861552, 3821.617838216156, 3374.240795820945, 3375.544301519288, 3377.1219482934366, 3378.9187460012804, 3402.1834759657504, 4699.412573428322, 4731.810727570893, 4731.976340118312, 4735.881602959919, 4793.760311984422, 4227.936580951288, 4328.891777705551, 4338.43600331958, 4348.456442944632, 4367.235733746614, 4938.530839570235, 4941.555260026615, 5008.69947803133, 5011.318944364747, 5033.597312215014, 3687.631236876318, 3691.8338674759702, 3692.058525076115, 3702.1670124222105, 3713.4032366082574, 5068.276785892815, 5181.1969144782615, 5204.635675502755, 5260.421353651095, 5268.841934741964, 3736.2153947671295, 3738.1776009277914, 3741.7193710471824, 3746.6066063062985, 3766.3408903441787, 3812.390017597171, 3828.1195325075387, 3834.8466061357235, 3838.0788610733225, 3844.308024555551, 4308.763018034038, 4310.8360742599325, 4311.267084595626, 4316.805743741539, 4321.092570560218, 4814.831480898151, 4974.626902982219, 4989.600831933437, 4997.775100120503, 5007.59635375022, 1288.1305119044607, 1298.3508245877063, 1308.2739079810797, 1308.9672758180932, 1316.7300703355788, 848.4697064334791, 857.6612238166015, 897.9326550508738, 904.7783293093235, 913.954302284883, 4459.175052615212, 4465.776711164429, 4486.214912390318, 4494.348319493721, 4496.797644106023, 5183.585313174937, 5200.453952335026, 5202.531772140525, 5228.764705588258, 5261.815836445706, 4304.870853874389, 4440.777961101932, 4488.618467430239, 4499.0776890737325, 4552.521985191574, 2790.260580946051, 2792.6229958955687, 2795.4548862971933, 2805.551111822099, 2815.4650616382824, 4808.158572249842, 4852.223644216979, 4882.292067650242, 4898.779554920037, 4901.681390709592, 5098.0, 5338.6529875558745, 5340.385855626652, 5389.353277606712, 5400.594955378362, 4915.729634870117, 4959.305697202322, 4960.627952903546, 4963.255511673206, 4967.70193788381, 5256.421793602777, 5278.313819203632, 5279.894402112013, 5285.894282114413, 5291.285676433632, 4837.37114175155, 5190.767969773034, 5193.61047921415, 5196.53231209193, 5206.687598744087, 4919.704817710805, 4964.180910149929, 4967.552920237196, 4971.130052240916, 4980.128477516348, 3754.7934863581672, 3766.4350347448103, 3766.7551609145316, 3781.111438811822, 3786.1481166737262, 5014.617266272878, 5186.948130518646, 5196.194589838581, 5197.688138711689, 5360.946390536201, 4995.775190116527, 5016.172331565251, 5030.647854650139, 5033.823816166417, 5048.5203905628905, 5038.269450929668, 5068.543831055223, 5078.7206703631655, 5089.51649593288, 5119.539241468136, 4757.3577567028005, 4785.688930219525, 5025.949740502549, 5037.513933389732, 5041.395032596112, 5000.599832047033, 5123.180291153398, 5124.8206312778875, 5128.282040514406, 5135.409427915837, 4994.101061808909, 4997.675151115312, 5013.498650134958, 5026.145555255688, 5037.874053148701], "value": 3836.639551794706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.9566030377872, 629.2511910826119, 645.3353046362248, 646.6152639179693, 783.690442275301, 12352.629421117359, 12770.553030643929, 13203.075784695064, 13214.801777973338, 13289.136206146593, 12558.120931534773, 12582.307973061477, 12675.873241267585, 12680.11239213253, 12702.23786572804, 609.8201030695933, 776.7941495503682, 776.8873513340562, 787.818801675615, 790.5572879187673, 795.6379847169524, 797.9162187970267, 807.9030516338048, 808.7775861638038, 808.8948436703221, 839.492107275099, 846.3652260804397, 850.8893843800297, 852.411835833273, 852.8209076094028, 657.81252343082, 807.6648191000728, 832.134580036761, 844.6072576252042, 845.5814371885895, 608.5253502268238, 609.3449541742644, 609.5854818723267, 609.689058580123, 609.7195290166529, 12709.0, 12755.362231888368, 12757.234565926074, 12766.489340426371, 12779.361031948365, 12671.429785659668, 13341.01485480431, 13346.199228046251, 13347.0, 13686.110402823784, 9515.524223788852, 9760.560774765081, 9869.555869985796, 10234.33476824004, 10335.431551264677, 3260.836958152083, 3363.9831800841084, 3364.142143753352, 3468.236987862666, 3490.2844916791996, 57830.42169578293, 58001.839963200924, 58441.0, 58676.70661646707, 59658.40341596615, 10342.482875856178, 10361.792764144826, 10418.843717344245, 10513.158947284199, 10608.0, 18363.63272734538, 18399.908000459913, 18404.447866564024, 18407.079646017646, 18416.539586510444, 6607.80176594703, 6667.966660166668, 6773.259848139462, 6904.654767261617, 6908.689108990107, 3723.702103831687, 3782.1868298315994, 3821.082940094357, 3845.788481633481, 3870.574236833946, 2920.751736102455, 3030.9997700758695, 3035.7267845893975, 3038.9392212155635, 3041.650210225808, 517.1260569637301, 520.258631450182, 520.5263210478522, 531.4446403508343, 538.2437675066537, 538.2410800770895, 545.3646501825408, 550.033200202175, 578.3522454850511, 581.4214856218006, 7850.921490785133, 7866.292033716993, 7956.641951112214, 7982.281594656509, 8135.983002124734, 548.4953842464942, 550.8237364043467, 551.2613098448098, 556.4852511426914, 572.9140628905615, 3742.4573436852047, 3775.962240377616, 3830.7649645446218, 4060.573639767782, 4112.0, 89412.5529372349, 90730.0, 91775.24674259782, 93119.0, 94215.52892235495, 76004.61997690087, 78362.0, 78618.0, 79322.6033869827, 79720.20279797244, 45328.54671453309, 45428.77285613551, 45622.54377456183, 65652.67173664102, 70599.64700176568, 7637.0, 7652.0, 7709.807254818675, 7761.0298712660915, 7868.173841746534, 44115.338269925334, 44665.55334446744, 45471.77264113658, 46466.07067858691, 46853.53146468628, 56816.0, 62011.0, 64099.35900640934, 64451.0, 64921.970457050644, 9842.557084931052, 9878.50607469638, 9924.15644670211, 10091.243156763125, 10518.737031574272, 10760.730981725519, 10800.405977671304, 10835.458227088771, 10938.890611093788, 11079.667609971713, 9733.853992189981, 10085.546150423395, 10163.593456261668, 10425.0, 10610.098141658045, 11843.58547450835, 11902.107341949215, 12192.146549741434, 12209.145359824726, 12885.42015609281, 11331.773364532499, 11597.710057248636, 11842.348670823187, 11996.64010079699, 12138.150329476852, 9356.391834530734, 9876.85184722244, 9982.900170998197, 10068.597256109673, 10277.756981358149, 8670.739877803677, 8726.869096963424, 8965.417247878868, 9009.864852027356, 9544.761380965532], "value": 6362.596733396046, "unit": "score"}], "name": "dromaeo_css", "value": 6254.310863404089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 113.0, 113.0, 111.0, 111.0, 116.0, 115.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 130.0, 131.0, 190.0, 133.0, 133.0, 152.0, 132.0, 162.0, 130.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 159.0, 162.0, 161.0, 160.0, 163.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 115.0, 77.0, 77.0, 75.0, 77.0, 102.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 116.0, 85.0, 85.0, 86.0, 122.0, 86.0, 85.0, 129.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 62.0, 63.0, 63.0, 64.0, 66.0, 63.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 87.0, 82.0, 86.0, 84.0, 88.0, 84.0, 115.0, 82.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 139.0, 128.0, 129.0, 131.0, 128.0, 130.0, 132.0, 134.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 172.0, 175.0, 172.0, 173.0, 172.0, 169.0, 172.0, 174.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 70.0, 68.0, 66.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1544.5, "alertThreshold": 2.0}]} 02:16:15 INFO - Return code: 0 02:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:16:15 INFO - # TBPL SUCCESS # 02:16:15 INFO - Running post-action listener: _resource_record_post_action 02:16:15 INFO - ##### 02:16:15 INFO - ##### Finished run-tests step (success) 02:16:15 INFO - ##### 02:16:15 INFO - Running post-run listener: _resource_record_post_run 02:16:15 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 309977088; Read time: 0; Write time: 270528 02:16:15 INFO - TinderboxPrint: CPU usage
13.1% 02:16:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:16:15 INFO - TinderboxPrint: I/O write bytes / time
309,977,088 / 270,528 02:16:15 INFO - TinderboxPrint: CPU idle
8,340.3 (86.9%) 02:16:15 INFO - TinderboxPrint: CPU user
1,212.5 (12.6%) 02:16:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:16:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16183296; Read time: 0; Write time: 2880 02:16:15 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292200448; Read time: 0; Write time: 263600 02:16:15 INFO - Running post-run listener: _upload_blobber_files 02:16:15 INFO - Blob upload gear active. 02:16:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:16:15 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 02:16:15 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'] 02:16:15 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 02:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:16 INFO - (blobuploader) - INFO - Done attempting. 02:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:20 INFO - (blobuploader) - INFO - Done attempting. 02:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:21 INFO - (blobuploader) - INFO - Done attempting. 02:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:16:21 INFO - Return code: 0 02:16:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/614bed1feb3c2060f4cf7f2e27cba9a992d50f2f80c90152877a0fffea5056945e438f18a5796f154a413f70a87e87875206aa8c36872e210e12a8ca81539251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14d62f4f79c736c4b23679884a5250383a751968c98d20e886e30454ef10dfc5d64fee5f7b8b32455e71d1a605e9197e09f98716a24a67f7f55da31355ff1fca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a94b2a7cce57979ac1114cae5f83f9277f2b277f39a02e85c3160d4de685a3dca1ab4bf2ecd8ceea789ae63dfcfb575118765fab3138a340a24259092f08111c"} 02:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:16:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:16:21 INFO - Contents: 02:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/614bed1feb3c2060f4cf7f2e27cba9a992d50f2f80c90152877a0fffea5056945e438f18a5796f154a413f70a87e87875206aa8c36872e210e12a8ca81539251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14d62f4f79c736c4b23679884a5250383a751968c98d20e886e30454ef10dfc5d64fee5f7b8b32455e71d1a605e9197e09f98716a24a67f7f55da31355ff1fca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a94b2a7cce57979ac1114cae5f83f9277f2b277f39a02e85c3160d4de685a3dca1ab4bf2ecd8ceea789ae63dfcfb575118765fab3138a340a24259092f08111c"} 02:16:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:16:21 INFO - Copying logs to upload dir... 02:16:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:16:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.879540 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-27 02:16:21.116301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 02:16:21.120058) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 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/614bed1feb3c2060f4cf7f2e27cba9a992d50f2f80c90152877a0fffea5056945e438f18a5796f154a413f70a87e87875206aa8c36872e210e12a8ca81539251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14d62f4f79c736c4b23679884a5250383a751968c98d20e886e30454ef10dfc5d64fee5f7b8b32455e71d1a605e9197e09f98716a24a67f7f55da31355ff1fca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a94b2a7cce57979ac1114cae5f83f9277f2b277f39a02e85c3160d4de685a3dca1ab4bf2ecd8ceea789ae63dfcfb575118765fab3138a340a24259092f08111c"} build_url:https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/Lyv-ChjdTo2qwLsqrpBUag/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/614bed1feb3c2060f4cf7f2e27cba9a992d50f2f80c90152877a0fffea5056945e438f18a5796f154a413f70a87e87875206aa8c36872e210e12a8ca81539251", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14d62f4f79c736c4b23679884a5250383a751968c98d20e886e30454ef10dfc5d64fee5f7b8b32455e71d1a605e9197e09f98716a24a67f7f55da31355ff1fca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a94b2a7cce57979ac1114cae5f83f9277f2b277f39a02e85c3160d4de685a3dca1ab4bf2ecd8ceea789ae63dfcfb575118765fab3138a340a24259092f08111c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 02:16:21.148535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:16:21.149152) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467017102.3169-550659790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004330 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 02:16:21.235558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 02:16:21.236295) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 02:16:21.236957) ========= ========= Total master_lag: 0.17 =========