builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1466680945.65 results: success (0) buildid: 20160623033425 builduid: 608f69613bb246deb2b38c49a903464b revision: 964138adafa9b8fe51703b4a89258f6aca9cf7d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.653344) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.653981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.654264) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.695830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.696104) ========= 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=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 04:22:26-- 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% 228M=0s 2016-06-23 04:22:26 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.895145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.895484) ========= 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=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014177 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.945417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:25.945943) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 964138adafa9b8fe51703b4a89258f6aca9cf7d5 --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 964138adafa9b8fe51703b4a89258f6aca9cf7d5 --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=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 04:22:26,412 truncating revision to first 12 chars 2016-06-23 04:22:26,412 Setting DEBUG logging. 2016-06-23 04:22:26,412 attempt 1/10 2016-06-23 04:22:26,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/964138adafa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 04:22:26,729 unpacking tar archive at: fx-team-964138adafa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673780 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:26.633438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:26.633759) ========= script_repo_revision: 964138adafa9b8fe51703b4a89258f6aca9cf7d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:26.634206) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:26.634527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 04:22:26.644713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-23 04:22:26.644993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:27 INFO - MultiFileLogger online at 20160623 04:22:27 in /builds/slave/test 04:22:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:27 INFO - {'append_to_log': False, 04:22:27 INFO - 'base_work_dir': '/builds/slave/test', 04:22:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:27 INFO - 'branch': 'Fx-Team-Non-PGO', 04:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:27 INFO - 'config_files': ('talos/linux_config.py',), 04:22:27 INFO - 'default_actions': ('clobber', 04:22:27 INFO - 'read-buildbot-config', 04:22:27 INFO - 'download-and-extract', 04:22:27 INFO - 'populate-webroot', 04:22:27 INFO - 'create-virtualenv', 04:22:27 INFO - 'install', 04:22:27 INFO - 'run-tests'), 04:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:27 INFO - 'download_minidump_stackwalk': True, 04:22:27 INFO - 'download_symbols': 'ondemand', 04:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:27 INFO - 'installer_path': 'installer.exe', 04:22:27 INFO - 'log_level': 'info', 04:22:27 INFO - 'log_name': 'talos', 04:22:27 INFO - 'log_to_console': True, 04:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:27 INFO - 'opt_config_files': (), 04:22:27 INFO - 'pip_index': False, 04:22:27 INFO - 'sps_profile': False, 04:22:27 INFO - 'sps_profile_interval': 0, 04:22:27 INFO - 'suite': 'dromaeojs-e10s', 04:22:27 INFO - 'system_bits': '32', 04:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:27 INFO - 'title': 'talos-linux64-ix-038', 04:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:27 INFO - 'use_talos_json': True, 04:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:27 INFO - 'work_dir': 'build'} 04:22:27 INFO - ##### 04:22:27 INFO - ##### Running clobber step. 04:22:27 INFO - ##### 04:22:27 INFO - Running pre-action listener: _resource_record_pre_action 04:22:27 INFO - Running main action method: clobber 04:22:27 INFO - rmtree: /builds/slave/test/build 04:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:28 INFO - Running post-action listener: _resource_record_post_action 04:22:28 INFO - ##### 04:22:28 INFO - ##### Finished clobber step (success) 04:22:28 INFO - ##### 04:22:28 INFO - ##### 04:22:28 INFO - ##### Running read-buildbot-config step. 04:22:28 INFO - ##### 04:22:28 INFO - Running pre-action listener: _resource_record_pre_action 04:22:28 INFO - Running main action method: read_buildbot_config 04:22:28 INFO - Using buildbot properties: 04:22:28 INFO - { 04:22:28 INFO - "project": "", 04:22:28 INFO - "product": "firefox", 04:22:28 INFO - "script_repo_revision": "production", 04:22:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:22:28 INFO - "repository": "", 04:22:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:22:28 INFO - "buildid": "20160623033425", 04:22:28 INFO - "pgo_build": "False", 04:22:28 INFO - "basedir": "/builds/slave/test", 04:22:28 INFO - "buildnumber": 1384, 04:22:28 INFO - "slavename": "talos-linux64-ix-038", 04:22:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:22:28 INFO - "platform": "ubuntu64_hw", 04:22:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:22:28 INFO - "branch": "fx-team", 04:22:28 INFO - "repo_path": "integration/fx-team", 04:22:28 INFO - "revision": "964138adafa9b8fe51703b4a89258f6aca9cf7d5", 04:22:28 INFO - "stage_platform": "linux64", 04:22:28 INFO - "builduid": "608f69613bb246deb2b38c49a903464b", 04:22:28 INFO - "slavebuilddir": "test" 04:22:28 INFO - } 04:22:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:22:28 INFO - Running post-action listener: _resource_record_post_action 04:22:28 INFO - ##### 04:22:28 INFO - ##### Finished read-buildbot-config step (success) 04:22:28 INFO - ##### 04:22:28 INFO - ##### 04:22:28 INFO - ##### Running download-and-extract step. 04:22:28 INFO - ##### 04:22:28 INFO - Running pre-action listener: _resource_record_pre_action 04:22:28 INFO - Running main action method: download_and_extract 04:22:28 INFO - mkdir: /builds/slave/test/build/tests 04:22: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')]} 04:22:28 INFO - https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:36 INFO - Downloaded 1361 bytes. 04:22:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:36 INFO - Using the following test package requirements: 04:22:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'jsshell-linux-x86_64.zip'], 04:22:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:36 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')]} 04:22:36 INFO - https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:46 INFO - Downloaded 22709579 bytes. 04:22:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:22:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:22:47 INFO - Return code: 0 04:22:47 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 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:47 INFO - https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:53 INFO - Downloaded 22709579 bytes. 04:22:53 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'] 04:22:53 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 04:22:55 INFO - Return code: 0 04:22: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')]} 04:22:55 INFO - https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:56 INFO - Downloaded 14405384 bytes. 04:22:56 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'] 04:22:56 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 04:22:56 INFO - Return code: 0 04:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:56 INFO - https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dgpJl358Sd6I5MKNdveJ0w/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 04:22:57 INFO - Downloaded 56247984 bytes. 04:22:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:57 INFO - mkdir: /builds/slave/test/properties 04:22:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:57 INFO - Contents: 04:22:57 INFO - build_url:https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:58 INFO - Running post-action listener: _resource_record_post_action 04:22:58 INFO - Running post-action listener: set_extra_try_arguments 04:22:58 INFO - ##### 04:22:58 INFO - ##### Finished download-and-extract step (success) 04:22:58 INFO - ##### 04:22:58 INFO - ##### 04:22:58 INFO - ##### Running populate-webroot step. 04:22:58 INFO - ##### 04:22:58 INFO - Running pre-action listener: _resource_record_pre_action 04:22:58 INFO - Running main action method: populate_webroot 04:22:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:58 INFO - '--tppagecycles', 04:22:58 INFO - '7'], 04:22:58 INFO - 'tests': ['tsvgm']}}, 04:22:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['damp', 'tps']}, 04:22:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'tests': ['damp', 'tps']}, 04:22:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['dromaeo_dom']}, 04:22:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['basic_compositor_video']}, 04:22:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:22:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['a11yr', 04:22:58 INFO - 'ts_paint', 04:22:58 INFO - 'tpaint', 04:22:58 INFO - 'sessionrestore', 04:22:58 INFO - 'sessionrestore_no_auto_restore', 04:22:58 INFO - 'tabpaint']}, 04:22:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['tsvgx', 04:22:58 INFO - 'tsvgr_opacity', 04:22:58 INFO - 'tart', 04:22:58 INFO - 'tscrollx', 04:22:58 INFO - 'cart']}, 04:22:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:58 INFO - 'tsvgr_opacity', 04:22:58 INFO - 'tart', 04:22:58 INFO - 'tscrollx', 04:22:58 INFO - 'cart']}, 04:22:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'talos_options': ['--disable-e10s'], 04:22:58 INFO - 'tests': ['tp5o']}, 04:22:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'tests': ['tp5o']}, 04:22:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'talos_options': ['--disable-e10s', 04:22:58 INFO - '--xperf_path', 04:22:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:58 INFO - 'tests': ['tp5n']}, 04:22:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:58 INFO - 'talos_options': ['--xperf_path', 04:22:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:58 INFO - 'tests': ['tp5n']}}, 04:22:58 INFO - 'talos.zip': {'path': '', 04:22:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:58 INFO - Running post-action listener: _resource_record_post_action 04:22:58 INFO - ##### 04:22:58 INFO - ##### Finished populate-webroot step (success) 04:22:58 INFO - ##### 04:22:58 INFO - ##### 04:22:58 INFO - ##### Running create-virtualenv step. 04:22:58 INFO - ##### 04:22:58 INFO - Running pre-action listener: _resource_record_pre_action 04:22:58 INFO - Running main action method: create_virtualenv 04:22:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:58 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 04:22:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:58 INFO - Using real prefix '/usr' 04:22:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:01 INFO - Installing pip.................done. 04:23:01 INFO - Return code: 0 04:23:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 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 04:23:01 INFO - Cleaning up... 04:23:01 INFO - Return code: 0 04:23:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:23:01 INFO - Using env: {'DISPLAY': ':0', 04:23:01 INFO - 'HOME': '/home/cltbld', 04:23:01 INFO - 'LANG': 'en_US.UTF-8', 04:23:01 INFO - 'LANGUAGE': 'en_US:en', 04:23:01 INFO - 'LOGNAME': 'cltbld', 04:23:01 INFO - 'MAIL': '/var/mail/cltbld', 04:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:01 INFO - 'MOZ_NO_REMOTE': '1', 04:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:01 INFO - 'NO_EM_RESTART': '1', 04:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:01 INFO - 'PWD': '/builds/slave/test', 04:23:01 INFO - 'SHELL': '/bin/bash', 04:23:01 INFO - 'SHLVL': '1', 04:23:01 INFO - 'TERM': 'linux', 04:23:01 INFO - 'TMOUT': '86400', 04:23:01 INFO - 'USER': 'cltbld', 04:23:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:01 INFO - '_': '/tools/buildbot/bin/python'} 04:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:01 INFO - Downloading/unpacking psutil>=3.1.1 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:03 INFO - Installing collected packages: psutil 04:23:03 INFO - Running setup.py install for psutil 04:23:03 INFO - building 'psutil._psutil_linux' extension 04:23:03 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 04:23:03 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 04:23:03 INFO - building 'psutil._psutil_posix' extension 04:23:03 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 04:23:04 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 04:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:04 INFO - Successfully installed psutil 04:23:04 INFO - Cleaning up... 04:23:04 INFO - Return code: 0 04:23:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23: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')]} 04:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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')]} 04:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:04 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:04 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 04:23:04 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 04:23:04 INFO - Using env: {'DISPLAY': ':0', 04:23:04 INFO - 'HOME': '/home/cltbld', 04:23:04 INFO - 'LANG': 'en_US.UTF-8', 04:23:04 INFO - 'LANGUAGE': 'en_US:en', 04:23:04 INFO - 'LOGNAME': 'cltbld', 04:23:04 INFO - 'MAIL': '/var/mail/cltbld', 04:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:04 INFO - 'MOZ_NO_REMOTE': '1', 04:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:04 INFO - 'NO_EM_RESTART': '1', 04:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:04 INFO - 'PWD': '/builds/slave/test', 04:23:04 INFO - 'SHELL': '/bin/bash', 04:23:04 INFO - 'SHLVL': '1', 04:23:04 INFO - 'TERM': 'linux', 04:23:04 INFO - 'TMOUT': '86400', 04:23:04 INFO - 'USER': 'cltbld', 04:23:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:04 INFO - '_': '/tools/buildbot/bin/python'} 04:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:06 INFO - Installing collected packages: mozsystemmonitor 04:23:06 INFO - Running setup.py install for mozsystemmonitor 04:23:06 INFO - Successfully installed mozsystemmonitor 04:23:06 INFO - Cleaning up... 04:23:06 INFO - Return code: 0 04:23:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:06 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')]} 04:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:06 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')]} 04:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:06 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:06 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 04:23:06 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 04:23:06 INFO - Using env: {'DISPLAY': ':0', 04:23:06 INFO - 'HOME': '/home/cltbld', 04:23:06 INFO - 'LANG': 'en_US.UTF-8', 04:23:06 INFO - 'LANGUAGE': 'en_US:en', 04:23:06 INFO - 'LOGNAME': 'cltbld', 04:23:06 INFO - 'MAIL': '/var/mail/cltbld', 04:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:06 INFO - 'MOZ_NO_REMOTE': '1', 04:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:06 INFO - 'NO_EM_RESTART': '1', 04:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:06 INFO - 'PWD': '/builds/slave/test', 04:23:06 INFO - 'SHELL': '/bin/bash', 04:23:06 INFO - 'SHLVL': '1', 04:23:06 INFO - 'TERM': 'linux', 04:23:06 INFO - 'TMOUT': '86400', 04:23:06 INFO - 'USER': 'cltbld', 04:23:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:06 INFO - '_': '/tools/buildbot/bin/python'} 04:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 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 04:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:08 INFO - warning: no files found matching '*.txt' 04:23:08 INFO - no previously-included directories found matching 'build' 04:23:08 INFO - no previously-included directories found matching 'dist' 04:23:08 INFO - no previously-included directories found matching '.git*' 04:23:08 INFO - Installing collected packages: jsonschema, functools32 04:23:09 INFO - Running setup.py install for functools32 04:23:09 INFO - warning: no files found matching '*.txt' 04:23:09 INFO - no previously-included directories found matching 'build' 04:23:09 INFO - no previously-included directories found matching 'dist' 04:23:09 INFO - no previously-included directories found matching '.git*' 04:23:09 INFO - Successfully installed jsonschema functools32 04:23:09 INFO - Cleaning up... 04:23:09 INFO - Return code: 0 04:23:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:09 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')]} 04:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:09 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')]} 04:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:09 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:09 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 04:23:09 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 04:23:09 INFO - Using env: {'DISPLAY': ':0', 04:23:09 INFO - 'HOME': '/home/cltbld', 04:23:09 INFO - 'LANG': 'en_US.UTF-8', 04:23:09 INFO - 'LANGUAGE': 'en_US:en', 04:23:09 INFO - 'LOGNAME': 'cltbld', 04:23:09 INFO - 'MAIL': '/var/mail/cltbld', 04:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:09 INFO - 'MOZ_NO_REMOTE': '1', 04:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:09 INFO - 'NO_EM_RESTART': '1', 04:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:09 INFO - 'PWD': '/builds/slave/test', 04:23:09 INFO - 'SHELL': '/bin/bash', 04:23:09 INFO - 'SHLVL': '1', 04:23:09 INFO - 'TERM': 'linux', 04:23:09 INFO - 'TMOUT': '86400', 04:23:09 INFO - 'USER': 'cltbld', 04:23:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:09 INFO - '_': '/tools/buildbot/bin/python'} 04:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:11 INFO - Downloading docopt-0.6.1.tar.gz 04:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:12 INFO - Running setup.py install for blobuploader 04:23:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:12 INFO - Running setup.py install for requests 04:23:12 INFO - Running setup.py install for docopt 04:23:12 INFO - Successfully installed blobuploader requests docopt 04:23:12 INFO - Cleaning up... 04:23:12 INFO - Return code: 0 04:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:12 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')]} 04:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:12 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')]} 04:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:12 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:12 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 04:23:12 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 04:23:12 INFO - Using env: {'DISPLAY': ':0', 04:23:12 INFO - 'HOME': '/home/cltbld', 04:23:12 INFO - 'LANG': 'en_US.UTF-8', 04:23:12 INFO - 'LANGUAGE': 'en_US:en', 04:23:12 INFO - 'LOGNAME': 'cltbld', 04:23:12 INFO - 'MAIL': '/var/mail/cltbld', 04:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:12 INFO - 'MOZ_NO_REMOTE': '1', 04:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:12 INFO - 'NO_EM_RESTART': '1', 04:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:12 INFO - 'PWD': '/builds/slave/test', 04:23:12 INFO - 'SHELL': '/bin/bash', 04:23:12 INFO - 'SHLVL': '1', 04:23:12 INFO - 'TERM': 'linux', 04:23:12 INFO - 'TMOUT': '86400', 04:23:12 INFO - 'USER': 'cltbld', 04:23:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:12 INFO - '_': '/tools/buildbot/bin/python'} 04:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:12 INFO - Running setup.py (path:/tmp/pip-xjzD8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:12 INFO - Running setup.py (path:/tmp/pip-INtPqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:12 INFO - Running setup.py (path:/tmp/pip-Q2KozN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:13 INFO - Running setup.py (path:/tmp/pip-V_f0yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:13 INFO - Running setup.py (path:/tmp/pip-b1AyuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:13 INFO - Running setup.py (path:/tmp/pip-MLkX3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:13 INFO - Running setup.py (path:/tmp/pip-ozpvqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:13 INFO - Running setup.py (path:/tmp/pip-vm2V2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:13 INFO - Running setup.py (path:/tmp/pip-nK4N1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:13 INFO - Running setup.py (path:/tmp/pip-5_oDGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:13 INFO - Running setup.py (path:/tmp/pip-Ez5eZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:13 INFO - Running setup.py (path:/tmp/pip-qzOcpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:13 INFO - Running setup.py (path:/tmp/pip-35bnYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:13 INFO - Running setup.py (path:/tmp/pip-QDYueE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:13 INFO - Running setup.py (path:/tmp/pip-wMpeIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:13 INFO - Running setup.py (path:/tmp/pip-g5iX0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:14 INFO - Running setup.py (path:/tmp/pip-bTwu3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:14 INFO - Running setup.py install for manifestparser 04:23:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Running setup.py install for mozcrash 04:23:14 INFO - Running setup.py install for mozdebug 04:23:14 INFO - Running setup.py install for mozdevice 04:23:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Running setup.py install for mozfile 04:23:14 INFO - Running setup.py install for mozhttpd 04:23:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Running setup.py install for mozinfo 04:23:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Running setup.py install for mozInstall 04:23:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:14 INFO - Running setup.py install for mozleak 04:23:14 INFO - Running setup.py install for mozlog 04:23:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Running setup.py install for moznetwork 04:23:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Running setup.py install for mozprocess 04:23:15 INFO - Running setup.py install for mozprofile 04:23:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Running setup.py install for mozrunner 04:23:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Running setup.py install for mozscreenshot 04:23:15 INFO - Running setup.py install for moztest 04:23:15 INFO - Running setup.py install for mozversion 04:23:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:15 INFO - Cleaning up... 04:23:15 INFO - Return code: 0 04:23:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:15 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:15 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 04:23:15 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 04:23:15 INFO - Using env: {'DISPLAY': ':0', 04:23:15 INFO - 'HOME': '/home/cltbld', 04:23:15 INFO - 'LANG': 'en_US.UTF-8', 04:23:15 INFO - 'LANGUAGE': 'en_US:en', 04:23:15 INFO - 'LOGNAME': 'cltbld', 04:23:15 INFO - 'MAIL': '/var/mail/cltbld', 04:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:15 INFO - 'MOZ_NO_REMOTE': '1', 04:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:15 INFO - 'NO_EM_RESTART': '1', 04:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:15 INFO - 'PWD': '/builds/slave/test', 04:23:15 INFO - 'SHELL': '/bin/bash', 04:23:15 INFO - 'SHLVL': '1', 04:23:15 INFO - 'TERM': 'linux', 04:23:15 INFO - 'TMOUT': '86400', 04:23:15 INFO - 'USER': 'cltbld', 04:23:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:15 INFO - '_': '/tools/buildbot/bin/python'} 04:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:16 INFO - Running setup.py (path:/tmp/pip-AzxcYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:16 INFO - Running setup.py (path:/tmp/pip-yyB6_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:16 INFO - Running setup.py (path:/tmp/pip-2QYXTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:16 INFO - Running setup.py (path:/tmp/pip-vehNbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:16 INFO - Running setup.py (path:/tmp/pip-CdHvnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:16 INFO - Running setup.py (path:/tmp/pip-GpBGQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:16 INFO - Running setup.py (path:/tmp/pip-RB54nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:16 INFO - Running setup.py (path:/tmp/pip-bzx39h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:16 INFO - Running setup.py (path:/tmp/pip-BrE_m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:16 INFO - Running setup.py (path:/tmp/pip-XD9VvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:16 INFO - Running setup.py (path:/tmp/pip-m0cynz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:16 INFO - Running setup.py (path:/tmp/pip-D2Yl1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:16 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)) 04:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:16 INFO - Running setup.py (path:/tmp/pip-5g82HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:17 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)) 04:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:17 INFO - Running setup.py (path:/tmp/pip-WEA9i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:17 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)) 04:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:17 INFO - Running setup.py (path:/tmp/pip-9YddQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:17 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)) 04:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:17 INFO - Running setup.py (path:/tmp/pip-0SaJTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:17 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)) 04:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:17 INFO - Running setup.py (path:/tmp/pip-s574h_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:17 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)) 04:23:17 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)) 04:23:17 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)) 04:23:17 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)) 04:23:17 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)) 04:23:17 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)) 04:23:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:19 INFO - Downloading blessings-1.6.tar.gz 04:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:19 INFO - Installing collected packages: blessings 04:23:19 INFO - Running setup.py install for blessings 04:23:19 INFO - Successfully installed blessings 04:23:19 INFO - Cleaning up... 04:23:19 INFO - Return code: 0 04:23:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:19 INFO - Reading from file tmpfile_stdout 04:23:19 INFO - Current package versions: 04:23:19 INFO - argparse == 1.2.1 04:23:19 INFO - blessings == 1.6 04:23:19 INFO - blobuploader == 1.2.4 04:23:19 INFO - docopt == 0.6.1 04:23:19 INFO - functools32 == 3.2.3-2 04:23:19 INFO - jsonschema == 2.5.1 04:23:19 INFO - manifestparser == 1.1 04:23:19 INFO - mozInstall == 1.12 04:23:19 INFO - mozcrash == 0.17 04:23:19 INFO - mozdebug == 0.1 04:23:19 INFO - mozdevice == 0.48 04:23:19 INFO - mozfile == 1.2 04:23:19 INFO - mozhttpd == 0.7 04:23:19 INFO - mozinfo == 0.9 04:23:19 INFO - mozleak == 0.1 04:23:19 INFO - mozlog == 3.2 04:23:19 INFO - moznetwork == 0.27 04:23:19 INFO - mozprocess == 0.22 04:23:19 INFO - mozprofile == 0.28 04:23:19 INFO - mozrunner == 6.11 04:23:19 INFO - mozscreenshot == 0.1 04:23:19 INFO - mozsystemmonitor == 0.3 04:23:19 INFO - moztest == 0.7 04:23:19 INFO - mozversion == 1.4 04:23:19 INFO - psutil == 3.1.1 04:23:19 INFO - requests == 1.2.3 04:23:19 INFO - wsgiref == 0.1.2 04:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:19 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 04:23:19 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 04:23:19 INFO - Using env: {'DISPLAY': ':0', 04:23:19 INFO - 'HOME': '/home/cltbld', 04:23:19 INFO - 'LANG': 'en_US.UTF-8', 04:23:19 INFO - 'LANGUAGE': 'en_US:en', 04:23:19 INFO - 'LOGNAME': 'cltbld', 04:23:19 INFO - 'MAIL': '/var/mail/cltbld', 04:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:19 INFO - 'MOZ_NO_REMOTE': '1', 04:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:19 INFO - 'NO_EM_RESTART': '1', 04:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:19 INFO - 'PWD': '/builds/slave/test', 04:23:19 INFO - 'SHELL': '/bin/bash', 04:23:19 INFO - 'SHLVL': '1', 04:23:19 INFO - 'TERM': 'linux', 04:23:19 INFO - 'TMOUT': '86400', 04:23:19 INFO - 'USER': 'cltbld', 04:23:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:19 INFO - '_': '/tools/buildbot/bin/python'} 04:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 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)) 04:23:19 INFO - Cleaning up... 04:23:19 INFO - Return code: 0 04:23:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:19 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:19 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 04:23:19 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 04:23:19 INFO - Using env: {'DISPLAY': ':0', 04:23:19 INFO - 'HOME': '/home/cltbld', 04:23:19 INFO - 'LANG': 'en_US.UTF-8', 04:23:19 INFO - 'LANGUAGE': 'en_US:en', 04:23:19 INFO - 'LOGNAME': 'cltbld', 04:23:19 INFO - 'MAIL': '/var/mail/cltbld', 04:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:19 INFO - 'MOZ_NO_REMOTE': '1', 04:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:19 INFO - 'NO_EM_RESTART': '1', 04:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:19 INFO - 'PWD': '/builds/slave/test', 04:23:19 INFO - 'SHELL': '/bin/bash', 04:23:19 INFO - 'SHLVL': '1', 04:23:19 INFO - 'TERM': 'linux', 04:23:19 INFO - 'TMOUT': '86400', 04:23:19 INFO - 'USER': 'cltbld', 04:23:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:19 INFO - '_': '/tools/buildbot/bin/python'} 04:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:20 INFO - Cleaning up... 04:23:20 INFO - Return code: 0 04:23:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:20 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 0x7f6516d6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe73450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, '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': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', '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 04:23:20 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 04:23:20 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 04:23:20 INFO - Using env: {'DISPLAY': ':0', 04:23:20 INFO - 'HOME': '/home/cltbld', 04:23:20 INFO - 'LANG': 'en_US.UTF-8', 04:23:20 INFO - 'LANGUAGE': 'en_US:en', 04:23:20 INFO - 'LOGNAME': 'cltbld', 04:23:20 INFO - 'MAIL': '/var/mail/cltbld', 04:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:20 INFO - 'MOZ_NO_REMOTE': '1', 04:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:20 INFO - 'NO_EM_RESTART': '1', 04:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:20 INFO - 'PWD': '/builds/slave/test', 04:23:20 INFO - 'SHELL': '/bin/bash', 04:23:20 INFO - 'SHLVL': '1', 04:23:20 INFO - 'TERM': 'linux', 04:23:20 INFO - 'TMOUT': '86400', 04:23:20 INFO - 'USER': 'cltbld', 04:23:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:20 INFO - '_': '/tools/buildbot/bin/python'} 04:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:20 INFO - Downloading/unpacking flake8 04:23:20 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 04:23:20 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 04:23:20 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 04:23:20 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 04:23:20 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 04:23:20 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 04:23:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 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 04:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:22 INFO - no previously-included directories found matching 'docs/_build' 04:23:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:23 INFO - Running setup.py install for pep8 04:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:23 INFO - no previously-included directories found matching 'docs/_build' 04:23:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:23 INFO - Cleaning up... 04:23:23 INFO - Return code: 0 04:23:23 INFO - Running post-action listener: _resource_record_post_action 04:23:23 INFO - Running post-action listener: _start_resource_monitoring 04:23:23 INFO - Starting resource monitoring. 04:23:23 INFO - ##### 04:23:23 INFO - ##### Finished create-virtualenv step (success) 04:23:23 INFO - ##### 04:23:23 INFO - ##### 04:23:23 INFO - ##### Running install step. 04:23:23 INFO - ##### 04:23:23 INFO - Running pre-action listener: _resource_record_pre_action 04:23:23 INFO - Running main action method: install 04:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:23 INFO - Reading from file tmpfile_stdout 04:23:23 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:23 INFO - Reading from file tmpfile_stdout 04:23:23 INFO - Output received: 04:23:23 INFO - Usage: mozinstall [options] installer 04:23:23 INFO - Options: 04:23:23 INFO - -h, --help show this help message and exit 04:23:23 INFO - -d DEST, --destination=DEST 04:23:23 INFO - Directory to install application into. [default: 04:23:23 INFO - "/builds/slave/test"] 04:23:23 INFO - --app=APP Application being installed. [default: firefox] 04:23:23 INFO - mkdir: /builds/slave/test/build/application 04:23:23 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'] 04:23:23 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 04:23:39 INFO - Reading from file tmpfile_stdout 04:23:39 INFO - Output received: 04:23:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:39 INFO - Running post-action listener: _resource_record_post_action 04:23:39 INFO - ##### 04:23:39 INFO - ##### Finished install step (success) 04:23:39 INFO - ##### 04:23:39 INFO - ##### 04:23:39 INFO - ##### Running run-tests step. 04:23:39 INFO - ##### 04:23:39 INFO - Running pre-action listener: _resource_record_pre_action 04:23:39 INFO - Running main action method: run_tests 04:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:39 INFO - Python 2.7.3 04:23:39 INFO - Return code: 0 04:23:39 INFO - grabbing minidump binary from tooltool 04:23: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')]} 04:23:39 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 0xf022c0>, '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 0xf031c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf03650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:39 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 04:23:39 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 04:23:39 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 04:23:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:39 INFO - Return code: 0 04:23:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:23:40 INFO - Return code: 0 04:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:23:40 INFO - Using env: {'DISPLAY': ':0', 04:23:40 INFO - 'HOME': '/home/cltbld', 04:23:40 INFO - 'LANG': 'en_US.UTF-8', 04:23:40 INFO - 'LANGUAGE': 'en_US:en', 04:23:40 INFO - 'LOGNAME': 'cltbld', 04:23:40 INFO - 'MAIL': '/var/mail/cltbld', 04:23:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:40 INFO - 'MOZ_NO_REMOTE': '1', 04:23:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:40 INFO - 'NO_EM_RESTART': '1', 04:23:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:40 INFO - 'PWD': '/builds/slave/test', 04:23:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:40 INFO - 'SHELL': '/bin/bash', 04:23:40 INFO - 'SHLVL': '1', 04:23:40 INFO - 'TERM': 'linux', 04:23:40 INFO - 'TMOUT': '86400', 04:23:40 INFO - 'USER': 'cltbld', 04:23:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680', 04:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:40 INFO - '_': '/tools/buildbot/bin/python'} 04:23:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:23:41 INFO - mozversion application_buildid: 20160623033425 04:23:41 INFO - mozversion application_changeset: 964138adafa9b8fe51703b4a89258f6aca9cf7d5 04:23:41 INFO - mozversion application_display_name: Nightly 04:23:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:41 INFO - mozversion application_name: Firefox 04:23:41 INFO - mozversion application_remotingname: firefox 04:23:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:23:41 INFO - mozversion application_vendor: Mozilla 04:23:41 INFO - mozversion application_version: 50.0a1 04:23:41 INFO - mozversion platform_buildid: 20160623033425 04:23:41 INFO - mozversion platform_changeset: 964138adafa9b8fe51703b4a89258f6aca9cf7d5 04:23:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:23:41 INFO - mozversion platform_version: 50.0a1 04:23:41 INFO - using testdate: 1466681021 04:23:41 INFO - actual date: 1466681021 04:23:41 INFO - starting webserver on 'localhost:53201' 04:23:41 INFO - SUITE-START | Running 2 tests 04:23:41 INFO - TEST-START | dromaeo_css 04:23:41 INFO - operating with platform_type : linux_ 04:23:41 INFO - Initialising browser for dromaeo_css test... 04:23:41 INFO - TEST-INFO | started process 6547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphJlgBP/profile http://localhost:53201/getInfo.html) 04:23:46 INFO - PROCESS | 6547 | __metrics Screen width/height:1600/1200 04:23:46 INFO - PROCESS | 6547 | colorDepth:24 04:23:46 INFO - PROCESS | 6547 | Browser inner width/height: 1024/697 04:23:46 INFO - PROCESS | 6547 | __metrics 04:23:47 ERROR - PROCESS | 6547 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:23:48 INFO - TEST-INFO | 6547: exit 0 04:23:48 INFO - Browser initialized. 04:23:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:48 INFO - TEST-INFO | started process 6666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphJlgBP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:00 INFO - PROCESS | 6666 | RSS: Main: 186118144 04:24:00 INFO - PROCESS | 6666 | 04:24:49 INFO - PROCESS | 6666 | 1466681089868 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] 04:27:02 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53201/tests/dromaeo/cssquery-ext.html) 04:27:03 INFO - PROCESS | 6666 | RSS: Main: 189313024 04:27:03 INFO - PROCESS | 6666 | 04:30:05 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-ext.html (next: http://localhost:53201/tests/dromaeo/cssquery-jquery.html) 04:30:06 INFO - PROCESS | 6666 | RSS: Main: 188121088 04:30:06 INFO - PROCESS | 6666 | 04:33:07 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53201/tests/dromaeo/cssquery-mootools.html) 04:33:08 INFO - PROCESS | 6666 | RSS: Main: 189382656 04:33:08 INFO - PROCESS | 6666 | 04:36:10 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53201/tests/dromaeo/cssquery-prototype.html) 04:36:11 INFO - PROCESS | 6666 | RSS: Main: 186789888 04:36:11 INFO - PROCESS | 6666 | 04:39:13 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53201/tests/dromaeo/cssquery-yui.html) 04:39:14 INFO - PROCESS | 6666 | RSS: Main: 188747776 04:39:14 INFO - PROCESS | 6666 | 04:42:16 INFO - PROCESS | 6666 | Cycle 1(1): loaded http://localhost:53201/tests/dromaeo/cssquery-yui.html (next: http://localhost:53201/tests/dromaeo/cssquery-dojo.html) 04:42:17 INFO - PROCESS | 6666 | RSS: Main: 189505536 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | __start_tp_report 04:42:17 INFO - PROCESS | 6666 | _x_x_mozilla_page_load 04:42:17 INFO - PROCESS | 6666 | _x_x_mozilla_page_load_details 04:42:17 INFO - PROCESS | 6666 | |i|pagename|runs| 04:42:17 INFO - PROCESS | 6666 | |0;dojo.html;2642.0884794745816;2651.3106592286026;2655.747703968123;2656.2562482504895;2679.544477438835;4878.0975519528865;4915.188993816025;4935.925961110582;4976;5048.368953880765;4902.166631672615;4907.631927605426;4916.901661966758;4925.950740492594;4952.455229924714;4467.151241264158;4500;4597.034622729214;4624.468186158584;4646.372739680134;474.43128343640643;4455.443069616298;4521.276595744682;4524.959259370346;4556.020455602045;4552.408186935694;4582.33556134362;4605.963658176917;4610.9308360374625;4627.606653434462;4575.359449677047;4597.678162528624;4619.653525985531;4625.444946606395;4644.651651126179;4420.270655341865;4469.910601787946;4470.687051906368;4498.932516012263;4512.548745125494;4878.780454879504;4957.107720610289;5003.724795136266;5011.699298042129;5060.797568097271;5303.522682958553;5376.569874410077;5381.461853814626;5383.4616538346245;5388.73056347185;5356.4107948125675;5365.168398898177;5369.221462887898;5389.461053894618;5422.783088676449;4981.227909674007;4984.800607975713;5007.24891266313;5013.699178049255;5039.0929632666475;5349.411564727877;5490.121580547093;5490.203920431515;5490.945090549123;5508.91736623951;5331.067063263991;5331.840044798662;5338.225957236179;5341.4925582069645;5395.109806881821;5414.458554144633;5424.132138857843;5442.700651464128;5451.155070964007;5464.7814087436855;5137.587163530059;5301.913107812889;5344.732763361816;5365.517103460707;5390.245365648812;5361.142217245222;5384.138537833927;5402.810901618424;5406.405295417501;5410.48600382963;4600.700954437951;4601.792919318572;4613.792379342937;4620.768961551977;4667.393238878924;3872.9419058714143;3881.573026967031;3883.417487376916;3916.96083039166;3944.467496887941;4577.244754615451;4589.2198326284615;4608.308753686973;4653.697509661861;4658.95341046592;5301.257823904656;5422.620416570881;5453.263809385682;5463.72681365938;5496.900619876041;4568.520305367889;4578.679492435497;4595.655325850575;4608.769561521977;4611.1930412177735;4782.139214941274;4796.088743138793;4841.903161936812;4843.660943733976;4891.168501354707;4920.8769780755765;5008.298838162733;5011.834877408581;5023.799048038038;5079.517445842565;5379.838604841861;5395.514403703685;5411.458854114557;5423.403425623257;5459.69971651563;5019.447860735243;5026.045051440215;5029.968856384506;5037.345145131109;5038.093143234107;5214.582833373397;5233.293505376725;5267.3152490176035;5287;5305.761240744098;5398.892022159614;5402.108652072364;5415.972920135374;5417.593680474059;5453.15476101205;5234.528892399702;5258.921116183337;5269.28864603289;5273.077211488051;5317.962997215506;5102.4897510248675;5133.255677926605;5162.070827251131;5212.635115541876;5231.790728370823;5092.719900405513;5106.923396148986;5136.691798492103;5142.254373115802;5156.587473002226;5254.632175747661;5262.842114736564;5265.2891859599995;5271;5281.419043905091;5011.198208286657;5072.137736584863;5128.692278463304;5162.354705661793;5185.714785686823 04:42:17 INFO - PROCESS | 6666 | |1;ext.html;540.5324394398843;571.6570057965218;589.6904125334199;596.5764307341788;612.8927437698403;36018.45972310418;36548.634513654855;39230;39457.408138877865;39622.80188599053;39678.404823927594;40279.39580906289;40472.39291410624;40604.79697601508;40725.59274407255;7834.490758100734;7911.802204944894;7938.523688578675;7953.522788632672;7953.840923181533;7459.440541959348;7868.449208555404;7913.564753938531;7917.168697286788;7924.3660507159575;7891.250331218525;7935.127136015034;7941.08677502086;7977.720779772709;7978.962734844462;7851.5681637509915;7872.960635196816;7908.723194688158;7917.247861453182;7932.603369831514;7837.647305871193;7850.882236766453;7876.960615196945;7889;7903.525788452711;38369.61630383688;38729.41905871414;38744.806275968724;38897.41653875194;38955.41566876499;3358.4794356874722;3771.181168976591;3778.9811050944845;3790.431435284702;3882.475865758143;29199.124026279245;29219.85390073036;29594.556081658793;29849.850750746107;30663.38673226545;3493.179102910814;3503.5795704515367;3530.3998320285614;3536.8585256589704;3611.0611241077245;257437;257785.99999999814;258025;259089;259234;31892.84053579717;32891.50662740061;33050;34433.82783086068;49889.25166122511;34114;34115;34137.65862341395;34501;34626;12481.75036499265;12620.81068783969;12632.747345053047;12646.114771966058;12702.745945081047;10950.06924411418;11136.554537818558;11185.32888026721;11207.775844483065;11347.319160850375;7906;7968.322692571081;8065.475744076616;8065.798355041171;8101.716439924574;3103.379324135182;3131.9843400783307;3137.8431078446442;3166.6200055993427;3168.5405616185526;871.9825603487894;892.6474042753076;893.271983333581;975.673149494913;992.7666998255404;27965;28009;28029;28440.146795596163;28827.7117228825;930.5672862119147;941.6139382853135;949.1552518258756;971.8979507151647;1010.8736407949007;14832.18422986746;15078.246087695572;15098.320575573905;15200.239988000556;15306.540803775904;374688;377986;378545;379117;382221;49201.753991229816;49230.50769492331;49611.503884961414;49738.75130624396;49793.75103124534;1165.3765235599083;1172.1501911114374;1194.50428072349;1200.5197920831563;1202.8857258560597;25276;27586.172414827586;27726.306842329104;27806.721932780412;28101.57847632328;43825.78087109544;43901;44027.77986110049;44098.338524922794;44099.559004409544;332286;332419;333140;333149;333202;24892.128775492773;25730;25809.096681616054;25993.22020339393;26181.345466363495;38776.80611596924;41048.79475602603;41990.58009419867;42270.78864605657;42380.788096059325;36336.818315908255;36839.26321473609;37132.25735485329;37157.81421092986;37354.43968340423;36616.81691591525;36870.63129368672;36995.8150209258;37033.25933481262;37083;34452.53880662202;35352.469712954844;35592.288154237285;36180.27639447249;36205.63794362128;31112.844435777675;32273.33498390691;32467.18832029218;32605;32664.51003235001;24894.502109958063;25061.373465663506;25314.546537011604;25337.239882803544;25390 04:42:17 INFO - PROCESS | 6666 | |2;jquery.html;370.34633871217324;376.3075940269904;376.992460150797;391.12973633665115;396.910695093604;15953.282102305395;16156.353745850167;17296.394626188103;17299.221535030923;17327.22027508762;14591.489297874576;16214.189290535456;17130.400435984742;17175;17279.913600432013;4592.540745925414;4791.544803243703;4829.661923665345;4830.541098595628;4846.273059041137;3470.6182319944787;5209.661372010826;5524.502794748471;5542.2517960075475;5549.223108764776;5537.916931246014;5550.77796888124;5559.054960656677;5579.888402231953;5615.298087739033;6019.668918209497;6122.418370254819;6133.907991380132;6152.292486364081;6177.196964394645;5431.51116399522;5449.4005659377435;5464.9453505464835;5468.6171967962255;5477.616566840323;12440.377981100908;12645.304508252042;12803.359832008455;12808.103432759617;16293.91853040739;1898.6202759448165;1923.6537423263808;1979.5546002149545;1997.131247907165;2059.1454546363393;9252.259819214514;9456.57445414958;9567.808643827155;10428.426436545988;13030.153040052366;1781.946541603754;1798.4514723009609;1836.4766041678058;1839.4481655503296;1865.4590168851016;62573.37426625766;62789.99999999954;63702.68148659274;64245.357546424406;64354;9801.647604574851;10040.397576145455;10217.18262538995;10322.741931451774;10464.110550603284;14084;14124.364403601863;14160.734282514748;14177.503787367392;14213.64465888361;7275.67259473325;7356.705731770776;7394.889076663854;7478.177400485943;7489.475736698488;6837.735019021397;6927.168739751262;6945.89581156283;6963.303669632996;7080.858382832314;4386.254336762694;4414.779261037;4445.711028783118;4446.510883802779;4546.499885012646;1680.899146051241;1744.322465016194;1872.5318670332417;1880.7366968624403;1881.8212269834344;802.6107337941094;831.8170002599419;866.467122719523;925.287528602972;949.9645386528717;16696.916515417346;17058.573535661708;17059.65880682404;17412.91293543524;17414.738778918327;860.6299291304799;870.2950610005915;885.7696998780364;898.1198425542874;940.722486866376;9376.249900007982;9671.564779584936;9718.514074296258;9813.460259685644;9873.60505579783;387850;388860;391214;399309;400193;76876.9606134535;81037.18962810414;81410;81597;84694.5765271182;906.619219927632;917.3440989692402;927.2906226736552;931.8788557487484;936.9156775890202;15278.847211527742;15510.457134000257;15697.529074127795;15827.446039389028;15916.965397249141;35986.28027439489;36869;37465;37634.43548346722;38362;51306;52335.73832130815;52583.21125183202;52664;53300.73349633227;6720.764773232913;7072;7289.052423184952;7317.0487836580905;7319.45104117204;11080.833787493355;11483.885161148282;11818;12205.572804951784;12234.388280586114;10105.949470252895;10272.33229840058;10290.485475726333;10400.323978941344;10402.427866467417;9486.383385080224;10302.948485257826;10430.895691042992;10448.843267350843;10519.631812886511;10613.681589552325;10643.308184967953;10784.08335291509;10869.184811139354;10875.564977401133;6682.298358672269;7028.9297107030325;7838.725644602411;8115.878261825959;8124.22819832115;9982.650607228712;10515.526801294112;10528.157747380345;10533.42066186367;10733.946330268298 04:42:17 INFO - PROCESS | 6666 | |3;mootools.html;1352.5198554513145;1392.728417958498;1461.817272840895;1627.3571939084054;1688.9915550422247;6763.458923286137;7526.473146879721;7860.646270917809;8196.180381961809;8197.180281971807;7706.961465192666;7823.92176078239;7949.721759738411;7953.840923181548;7966.760997170094;2186.8250539956766;2221.655643375271;2225.643896976484;2227.1536816009975;2227.9108835646553;2153.6446486329814;2177.042101475354;2197.055266235518;2205.106931692667;2211.5355775287208;2163.8485306028583;2174.652055671093;2181.4982554012586;2186.365953873375;2189.321310393783;2150.956980860382;2160.8487405881515;2161.4056134562966;2164.9783502164933;2167.41479800453;2123.5115923337567;2132.86136401135;2141.0472339808794;2150.161437039556;2164.14516266074;7935.246151615645;7938.722144724907;7988.121306656263;7989.920100798976;7994.680212791482;4566.1552612766745;4703.3885594872445;4713.505081966413;4716.363290955712;4722.362481065046;2972.628421447319;3083.167544762924;3113.8443077846246;3143.245621050954;3163.351512939842;902.4179404284265;925.0887875442684;938.6104766521885;949.3307218411072;953.423178976716;10746.462676866126;10796.892031079668;10813.783724325549;10834.945825270903;10844.13246940243;4241.681873859473;4315.352697095461;4332.566743325642;4450;4452.48796388413;9176.770580735534;9201.677941272023;9201.723948281562;9205.907940920639;9242.306826988002;4764.14245435818;4788.880277993078;4803.543663351976;4810.807567697253;4826.541478559531;3798.9810050950123;4261.360795880581;4297.935530967038;4359.694821362475;4459.754713490789;3641.435577485494;3699.963000370016;3737.4206997915367;3769.8869033929027;3935.2916475034767;1206.240068756695;1211.061427393777;1216.1912328301757;1218.695326168458;1226.3132645718426;788.5741699482215;795.5783434779576;798.66456088443;800.8838718385917;807.2492581898773;4992.001599680006;5003.149464591028;5033.345665063518;5111.514406131411;5147.639665223398;405.7220803749441;412.12012353625227;417.64917469325303;423.66530440951306;436.79034063648993;3430.8627654893526;3488.7383446241124;3490.127468132967;3494.1264683829045;3514.2093029068765;9203;9292.953535232416;9532.714018579454;9561.808763824685;9564.856527151958;9347.158755712018;9365.578548965314;9395.436273823592;9400.435973841591;9421.104995025462;7070.080889484334;7255.746048888263;7321.304476074764;7330.926690733131;7341.559506429739;4764.118638051971;4835.226363781778;4852.2479015752615;4959.603231741524;4999.525045120708;8404.621792019252;8803.779905502413;9017.323700722603;9018.458892466473;9185.816283674423;9225.86161207569;9287.396319239228;9398.389104708172;9424.104710052809;9473.005334439784;6234.937650623436;6991.3008699131715;7128;7152.24901385347;7426.443016773872;7457;7688.231176882267;7690.615469226628;7750.379969602531;7756.3019328260725;6790.898136528055;6851.794446166623;6931.4108300795;7096.680649370687;7117.822054448473;6884.208316043719;6914.412274956685;6931.2375638678695;6966.825829354307;6979.371856532936;6022.1870047543025;6086.786962456293;6098.573099882966;6113.14415981754;6137.048757442603;4446.221911165598;4493.528179541101;4514.187446259705;4515.571020753023;4536.88657783558;4437.755923424243;4548.20406428867;4567.680262381601;4602.930956035595;4614.823220078858 04:42:17 INFO - PROCESS | 6666 | |4;prototype.html;295.63932002956386;303.1375736030992;312.8498320806014;312.9217695576106;313.3279116295546;5013.470891378128;5060.392752869651;5195;5228.8692782680455;5254.868628284295;4994.200927851544;5023.648344615878;5117.104506711329;5124.385073791141;5157.58739300856;4015.2973229684835;4026.2953983052994;4028.1742242840296;4028.8791336259815;4044.6966477514156;3939.1924655445564;4035.61661642145;4043.1913617276514;4047.8380864765372;4061.2689715851134;3933.547642021161;3984.581618930014;3992.800359982004;4012;4020.738651987626;3990.940135897964;3991.3214753491975;3991.600839916014;3997.8600748973645;4040.949353168168;3553.614090504705;3562.020444377817;3571.839152275521;3576.247638657065;3587;4856.660033797601;4997.775100120467;5015.84952451427;5025.246213068032;5114.721319670082;4568.908621827545;4574.176648203322;4629.65277604181;4639.448303433132;4648.442186937556;5362.973185134088;5371.435999220064;5387;5389.892202155974;5397.757100930428;3729.9067523311865;3844.8654297099465;3875.4380614810975;3878.3019056569806;3903.551091624471;5518.2826232589905;5531.419200983879;5595.272614560081;5602.355729091125;5672.149177623348;3944.36890097583;3970.9278494806817;3978.8209530571194;3979.1643754811234;3981.163955569305;3807.3527500325013;4037.596240375939;4039.5758445363404;4045.777482238505;4064.8577299794365;4507.729536227836;4533.002739397327;4558.225101732647;4559.863204103882;4587.564181402761;5356.598255130881;5363.356397232357;5382.327209098863;5411.864703382447;5424.159255315353;1314.822498962647;1384.6261509392407;1416.6812467194798;1423.2954687429788;1425.7861320801962;909.6361455417886;918.9799322751741;928.1924725488868;933.2347475070512;942.1144124522926;4175.373693945871;4193.937090943638;4196.685248606367;4207.664746065962;4223.345381465878;4879.316895634614;4884.291777692215;4888.9755551222015;4931.087748766489;4977.203647416396;4117.044403908179;4188.60208280219;4200.626645945032;4206.305959516707;4218.6414154797185;2504.8747562621797;2658.670664667666;2664.706882242952;2665.160474450542;2668.8799004044863;4566.4748553916725;4575.6044406455685;4584.587387135174;4616.699914505546;4645.674802763841;4923.873340428782;4987.628402189427;5009.699418034929;5010.845336505337;5029.949700503022;4278.72188307759;4564.7032942858605;4591.540845915381;4610.170169369479;4616.584507394351;4848.272759086165;4859;4862.343583616166;4888.877778055577;4916.680415772963;4792.760361981817;4797.784099715452;4799.3760811094335;4817.373741413594;4862.124817532878;4420.381146639537;4589.518100599389;4599.770011499479;4611.262198048296;4665.720056796467;3642.8107676172613;3659.9817000914827;3671.980410774117;3679.374506333876;3711.777293362407;4926.556609905126;4957.553820156203;4978.900421991612;4992.700437973734;5318.361796584435;5217.921731173959;5458.235846981346;5463.262459567907;5474.069408200695;5488.81990372072;5423.430539793265;5470.343558772973;5472.261244731911;5474.2609747683555;5478.397376288684;5115.74421278942;5291.1798671206025;5293.708846013506;5324;5348.090824559757;5435.184722291688;5438.728063596884;5440.483154100354;5466.808661696821;5467.425920278313;5228.37259528859;5302.814401495929;5312.910853275147;5361.463853614608;5370.436104209158 04:42:17 INFO - PROCESS | 6666 | |5;yui.html;631.9494440444764;685.4927353758218;703.3353480960494;743.4869939741578;757.4281417529766;12773.808392874103;13472.595822125328;13477.797833032513;13501.864981350183;13544.255065971367;12499.750004999894;13166.27585482798;13190.34048297586;13203.933980330085;13218.93390533046;616.0758861707438;760.6424980259269;776.926192011758;787.9172686867882;789.8222899847545;768.6387397922967;770.0682174568778;770.8573913825932;772.0349563046192;773.8993930788989;831.733845169546;834.1950018232404;834.8163404051099;834.8789425533294;835.0105125426359;825.4840724547158;828.6643909216776;830.9861968398544;831.0110967948152;831.6257684042145;607.5898768331402;609.6189881324173;609.6524980760968;610.1762620462384;610.4719417703654;12664.17682850621;12693.11148219625;12762.361881905868;12767.23396596198;12830.615081547476;12642.178258413174;13060.934695326558;13353.933230333883;13454.798178027337;13531.932340338333;10470.685879423554;10564.15486761065;10802.351858888413;10818.134549236122;10998.560057597686;3400.1159698478573;3462.0652423845672;3467.601225859033;3485.494603282535;3492.1269682579355;63639;64112.679436602986;64702.67648661727;65150.674246628936;65384;10553.84169237462;10564.894351056544;10746.73133171677;10930.508127134299;11059.281146725438;20824.27115050966;20842.68735968962;20870.26954056631;20934.37196884096;20938.267160649306;7113.181984071898;7206.7117315306805;7226.096737907762;7280.781576552712;7356.301151390609;3623.3146361007707;3782.5460944686815;3841.5582208045876;3844.3464611016193;3964.72246942717;3055.724984751383;3169.904902852918;3177.4757165067504;3177.920551986219;3180.80915145092;550.9889802203934;574.9770009199668;579.6058680097574;587.806024012075;588.632104934416;613.8772245550907;622.483338828771;643.5109316919176;658.1937127019459;659.0904551718597;8241.83516329682;8381.539015354214;8434.24091831738;8713.25937295337;8803.119688031275;514.6294667839225;530.615303904666;572.653544605516;586.9288548399188;623.3423737956409;3471.6354782747953;3571.196480791801;3637.0725465006253;3736.8505259789304;4334.891627709332;52705.736471317396;53804.192937105974;54097.72951135219;54246;63145.684271579266;78338.60830695924;80803.5959820209;81449.59275203587;81783;82981.58509207415;70028.2997170032;73532.63233683797;73850.89223661649;74109;74402;8121.201882226635;8148.185181481805;8234.547099909563;8276.255137037455;8406.453580517247;41175.794121029205;41683.19496078113;41916;42407.15185696207;42523.574764251964;54447.72776136253;61753;62657.373426265156;63516.364836351044;63664.68167659132;10021;10093.394396336244;10187.643432479828;10429.582816687247;10557.419341936267;10126.291159618757;10285.177185824967;10976.835347469634;11053.613123540637;12163.878361216275;12155;12258.448369823558;12719.682007949876;12728.23630582168;12869.420876060787;12014.939925300318;12143.249924451426;12154.453049612612;12545.372731363577;12757.74484510286;11499.8275025873;11704.414779260833;11899.405029748652;12620;12881.291528965998;10066.597336106473;10333.173346132442;10696.89303106959;10794.892051079389;10898.455077245948;9717.9028209717;10167.949160254151;10294.845577316497;10556.947215263874;10562.31344962575 04:42:17 INFO - PROCESS | 6666 | __end_tp_report 04:42:17 INFO - PROCESS | 6666 | __start_cc_report 04:42:17 INFO - PROCESS | 6666 | _x_x_mozilla_cycle_collect,399 04:42:17 INFO - PROCESS | 6666 | __end_cc_report 04:42:17 INFO - PROCESS | 6666 | __startTimestamp1466682137109__endTimestamp 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | ------- Summary: start ------- 04:42:17 INFO - PROCESS | 6666 | Number of tests: 6 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#0] dojo.html Cycles:165 Average:4916.39 Median:5039.09 stddev:651.83 (12.9%) stddev-sans-first:628.94 04:42:17 INFO - PROCESS | 6666 | Values: 2642.1 2651.3 2655.7 2656.3 2679.5 4878.1 4915.2 4935.9 4976.0 5048.4 4902.2 4907.6 4916.9 4926.0 4952.5 4467.2 4500.0 4597.0 4624.5 4646.4 474.4 4455.4 4521.3 4525.0 4556.0 4552.4 4582.3 4606.0 4610.9 4627.6 4575.4 4597.7 4619.7 4625.4 4644.7 4420.3 4469.9 4470.7 4498.9 4512.5 4878.8 4957.1 5003.7 5011.7 5060.8 5303.5 5376.6 5381.5 5383.5 5388.7 5356.4 5365.2 5369.2 5389.5 5422.8 4981.2 4984.8 5007.2 5013.7 5039.1 5349.4 5490.1 5490.2 5490.9 5508.9 5331.1 5331.8 5338.2 5341.5 5395.1 5414.5 5424.1 5442.7 5451.2 5464.8 5137.6 5301.9 5344.7 5365.5 5390.2 5361.1 5384.1 5402.8 5406.4 5410.5 4600.7 4601.8 4613.8 4620.8 4667.4 3872.9 3881.6 3883.4 3917.0 3944.5 4577.2 4589.2 4608.3 4653.7 4659.0 5301.3 5422.6 5453.3 5463.7 5496.9 4568.5 4578.7 4595.7 4608.8 4611.2 4782.1 4796.1 4841.9 4843.7 4891.2 4920.9 5008.3 5011.8 5023.8 5079.5 5379.8 5395.5 5411.5 5423.4 5459.7 5019.4 5026.0 5030.0 5037.3 5038.1 5214.6 5233.3 5267.3 5287.0 5305.8 5398.9 5402.1 5416.0 5417.6 5453.2 5234.5 5258.9 5269.3 5273.1 5318.0 5102.5 5133.3 5162.1 5212.6 5231.8 5092.7 5106.9 5136.7 5142.3 5156.6 5254.6 5262.8 5265.3 5271.0 5281.4 5011.2 5072.1 5128.7 5162.4 5185.7 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#1] ext.html Cycles:180 Average:46408.59 Median:36854.95 stddev:86225.55 (234.0%) stddev-sans-first:86398.66 04:42:17 INFO - PROCESS | 6666 | Values: 540.5 571.7 589.7 596.6 612.9 36018.5 36548.6 39230.0 39457.4 39622.8 39678.4 40279.4 40472.4 40604.8 40725.6 7834.5 7911.8 7938.5 7953.5 7953.8 7459.4 7868.4 7913.6 7917.2 7924.4 7891.3 7935.1 7941.1 7977.7 7979.0 7851.6 7873.0 7908.7 7917.2 7932.6 7837.6 7850.9 7877.0 7889.0 7903.5 38369.6 38729.4 38744.8 38897.4 38955.4 3358.5 3771.2 3779.0 3790.4 3882.5 29199.1 29219.9 29594.6 29849.9 30663.4 3493.2 3503.6 3530.4 3536.9 3611.1 257437.0 257786.0 258025.0 259089.0 259234.0 31892.8 32891.5 33050.0 34433.8 49889.3 34114.0 34115.0 34137.7 34501.0 34626.0 12481.8 12620.8 12632.7 12646.1 12702.7 10950.1 11136.6 11185.3 11207.8 11347.3 7906.0 7968.3 8065.5 8065.8 8101.7 3103.4 3132.0 3137.8 3166.6 3168.5 872.0 892.6 893.3 975.7 992.8 27965.0 28009.0 28029.0 28440.1 28827.7 930.6 941.6 949.2 971.9 1010.9 14832.2 15078.2 15098.3 15200.2 15306.5 374688.0 377986.0 378545.0 379117.0 382221.0 49201.8 49230.5 49611.5 49738.8 49793.8 1165.4 1172.2 1194.5 1200.5 1202.9 25276.0 27586.2 27726.3 27806.7 28101.6 43825.8 43901.0 44027.8 44098.3 44099.6 332286.0 332419.0 333140.0 333149.0 333202.0 24892.1 25730.0 25809.1 25993.2 26181.3 38776.8 41048.8 41990.6 42270.8 42380.8 36336.8 36839.3 37132.3 37157.8 37354.4 36616.8 36870.6 36995.8 37033.3 37083.0 34452.5 35352.5 35592.3 36180.3 36205.6 31112.8 32273.3 32467.2 32605.0 32664.5 24894.5 25061.4 25314.5 25337.2 25390.0 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#2] jquery.html Cycles:180 Average:24287.16 Median:4400.52 stddev:64974.22 (1476.5%) stddev-sans-first:65131.67 04:42:17 INFO - PROCESS | 6666 | Values: 370.3 376.3 377.0 391.1 396.9 15953.3 16156.4 17296.4 17299.2 17327.2 14591.5 16214.2 17130.4 17175.0 17279.9 4592.5 4791.5 4829.7 4830.5 4846.3 3470.6 5209.7 5524.5 5542.3 5549.2 5537.9 5550.8 5559.1 5579.9 5615.3 6019.7 6122.4 6133.9 6152.3 6177.2 5431.5 5449.4 5464.9 5468.6 5477.6 12440.4 12645.3 12803.4 12808.1 16293.9 1898.6 1923.7 1979.6 1997.1 2059.1 9252.3 9456.6 9567.8 10428.4 13030.2 1781.9 1798.5 1836.5 1839.4 1865.5 62573.4 62790.0 63702.7 64245.4 64354.0 9801.6 10040.4 10217.2 10322.7 10464.1 14084.0 14124.4 14160.7 14177.5 14213.6 7275.7 7356.7 7394.9 7478.2 7489.5 6837.7 6927.2 6945.9 6963.3 7080.9 4386.3 4414.8 4445.7 4446.5 4546.5 1680.9 1744.3 1872.5 1880.7 1881.8 802.6 831.8 866.5 925.3 950.0 16696.9 17058.6 17059.7 17412.9 17414.7 860.6 870.3 885.8 898.1 940.7 9376.2 9671.6 9718.5 9813.5 9873.6 387850.0 388860.0 391214.0 399309.0 400193.0 76877.0 81037.2 81410.0 81597.0 84694.6 906.6 917.3 927.3 931.9 936.9 15278.8 15510.5 15697.5 15827.4 15917.0 35986.3 36869.0 37465.0 37634.4 38362.0 51306.0 52335.7 52583.2 52664.0 53300.7 6720.8 7072.0 7289.1 7317.0 7319.5 11080.8 11483.9 11818.0 12205.6 12234.4 10105.9 10272.3 10290.5 10400.3 10402.4 9486.4 10302.9 10430.9 10448.8 10519.6 10613.7 10643.3 10784.1 10869.2 10875.6 6682.3 7028.9 7838.7 8115.9 8124.2 9982.7 10515.5 10528.2 10533.4 10733.9 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#3] mootools.html Cycles:180 Average:5158.57 Median:4830.88 stddev:2915.21 (60.3%) stddev-sans-first:2909.36 04:42:17 INFO - PROCESS | 6666 | Values: 1352.5 1392.7 1461.8 1627.4 1689.0 6763.5 7526.5 7860.6 8196.2 8197.2 7707.0 7823.9 7949.7 7953.8 7966.8 2186.8 2221.7 2225.6 2227.2 2227.9 2153.6 2177.0 2197.1 2205.1 2211.5 2163.8 2174.7 2181.5 2186.4 2189.3 2151.0 2160.8 2161.4 2165.0 2167.4 2123.5 2132.9 2141.0 2150.2 2164.1 7935.2 7938.7 7988.1 7989.9 7994.7 4566.2 4703.4 4713.5 4716.4 4722.4 2972.6 3083.2 3113.8 3143.2 3163.4 902.4 925.1 938.6 949.3 953.4 10746.5 10796.9 10813.8 10834.9 10844.1 4241.7 4315.4 4332.6 4450.0 4452.5 9176.8 9201.7 9201.7 9205.9 9242.3 4764.1 4788.9 4803.5 4810.8 4826.5 3799.0 4261.4 4297.9 4359.7 4459.8 3641.4 3700.0 3737.4 3769.9 3935.3 1206.2 1211.1 1216.2 1218.7 1226.3 788.6 795.6 798.7 800.9 807.2 4992.0 5003.1 5033.3 5111.5 5147.6 405.7 412.1 417.6 423.7 436.8 3430.9 3488.7 3490.1 3494.1 3514.2 9203.0 9293.0 9532.7 9561.8 9564.9 9347.2 9365.6 9395.4 9400.4 9421.1 7070.1 7255.7 7321.3 7330.9 7341.6 4764.1 4835.2 4852.2 4959.6 4999.5 8404.6 8803.8 9017.3 9018.5 9185.8 9225.9 9287.4 9398.4 9424.1 9473.0 6234.9 6991.3 7128.0 7152.2 7426.4 7457.0 7688.2 7690.6 7750.4 7756.3 6790.9 6851.8 6931.4 7096.7 7117.8 6884.2 6914.4 6931.2 6966.8 6979.4 6022.2 6086.8 6098.6 6113.1 6137.0 4446.2 4493.5 4514.2 4515.6 4536.9 4437.8 4548.2 4567.7 4602.9 4614.8 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#4] prototype.html Cycles:180 Average:4298.90 Median:4634.55 stddev:1233.50 (26.6%) stddev-sans-first:1199.80 04:42:17 INFO - PROCESS | 6666 | Values: 295.6 303.1 312.8 312.9 313.3 5013.5 5060.4 5195.0 5228.9 5254.9 4994.2 5023.6 5117.1 5124.4 5157.6 4015.3 4026.3 4028.2 4028.9 4044.7 3939.2 4035.6 4043.2 4047.8 4061.3 3933.5 3984.6 3992.8 4012.0 4020.7 3990.9 3991.3 3991.6 3997.9 4040.9 3553.6 3562.0 3571.8 3576.2 3587.0 4856.7 4997.8 5015.8 5025.2 5114.7 4568.9 4574.2 4629.7 4639.4 4648.4 5363.0 5371.4 5387.0 5389.9 5397.8 3729.9 3844.9 3875.4 3878.3 3903.6 5518.3 5531.4 5595.3 5602.4 5672.1 3944.4 3970.9 3978.8 3979.2 3981.2 3807.4 4037.6 4039.6 4045.8 4064.9 4507.7 4533.0 4558.2 4559.9 4587.6 5356.6 5363.4 5382.3 5411.9 5424.2 1314.8 1384.6 1416.7 1423.3 1425.8 909.6 919.0 928.2 933.2 942.1 4175.4 4193.9 4196.7 4207.7 4223.3 4879.3 4884.3 4889.0 4931.1 4977.2 4117.0 4188.6 4200.6 4206.3 4218.6 2504.9 2658.7 2664.7 2665.2 2668.9 4566.5 4575.6 4584.6 4616.7 4645.7 4923.9 4987.6 5009.7 5010.8 5029.9 4278.7 4564.7 4591.5 4610.2 4616.6 4848.3 4859.0 4862.3 4888.9 4916.7 4792.8 4797.8 4799.4 4817.4 4862.1 4420.4 4589.5 4599.8 4611.3 4665.7 3642.8 3660.0 3672.0 3679.4 3711.8 4926.6 4957.6 4978.9 4992.7 5318.4 5217.9 5458.2 5463.3 5474.1 5488.8 5423.4 5470.3 5472.3 5474.3 5478.4 5115.7 5291.2 5293.7 5324.0 5348.1 5435.2 5438.7 5440.5 5466.8 5467.4 5228.4 5302.8 5312.9 5361.5 5370.4 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - PROCESS | 6666 | [#5] yui.html Cycles:180 Average:16549.34 Median:42161.58 stddev:22027.31 (52.2%) stddev-sans-first:22056.68 04:42:17 INFO - PROCESS | 6666 | Values: 631.9 685.5 703.3 743.5 757.4 12773.8 13472.6 13477.8 13501.9 13544.3 12499.8 13166.3 13190.3 13203.9 13218.9 616.1 760.6 776.9 787.9 789.8 768.6 770.1 770.9 772.0 773.9 831.7 834.2 834.8 834.9 835.0 825.5 828.7 831.0 831.0 831.6 607.6 609.6 609.7 610.2 610.5 12664.2 12693.1 12762.4 12767.2 12830.6 12642.2 13060.9 13353.9 13454.8 13531.9 10470.7 10564.2 10802.4 10818.1 10998.6 3400.1 3462.1 3467.6 3485.5 3492.1 63639.0 64112.7 64702.7 65150.7 65384.0 10553.8 10564.9 10746.7 10930.5 11059.3 20824.3 20842.7 20870.3 20934.4 20938.3 7113.2 7206.7 7226.1 7280.8 7356.3 3623.3 3782.5 3841.6 3844.3 3964.7 3055.7 3169.9 3177.5 3177.9 3180.8 551.0 575.0 579.6 587.8 588.6 613.9 622.5 643.5 658.2 659.1 8241.8 8381.5 8434.2 8713.3 8803.1 514.6 530.6 572.7 586.9 623.3 3471.6 3571.2 3637.1 3736.9 4334.9 52705.7 53804.2 54097.7 54246.0 63145.7 78338.6 80803.6 81449.6 81783.0 82981.6 70028.3 73532.6 73850.9 74109.0 74402.0 8121.2 8148.2 8234.5 8276.3 8406.5 41175.8 41683.2 41916.0 42407.2 42523.6 54447.7 61753.0 62657.4 63516.4 63664.7 10021.0 10093.4 10187.6 10429.6 10557.4 10126.3 10285.2 10976.8 11053.6 12163.9 12155.0 12258.4 12719.7 12728.2 12869.4 12014.9 12143.2 12154.5 12545.4 12757.7 11499.8 11704.4 11899.4 12620.0 12881.3 10066.6 10333.2 10696.9 10794.9 10898.5 9717.9 10167.9 10294.8 10556.9 10562.3 04:42:17 INFO - PROCESS | 6666 | -------- Summary: end -------- 04:42:17 INFO - PROCESS | 6666 | 04:42:17 INFO - TEST-INFO | 6666: exit 0 04:42:17 INFO - TEST-OK | dromaeo_css | took 1116951ms 04:42:17 INFO - TEST-START | kraken 04:42:17 INFO - operating with platform_type : linux_ 04:42:17 INFO - Initialising browser for kraken test... 04:42:18 INFO - TEST-INFO | started process 6898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpul3Fqb/profile http://localhost:53201/getInfo.html) 04:42:23 INFO - PROCESS | 6898 | __metrics Screen width/height:1600/1200 04:42:23 INFO - PROCESS | 6898 | colorDepth:24 04:42:23 INFO - PROCESS | 6898 | Browser inner width/height: 1024/697 04:42:23 INFO - PROCESS | 6898 | __metrics 04:42:24 ERROR - PROCESS | 6898 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:42:24 INFO - TEST-INFO | 6898: exit 0 04:42:24 INFO - Browser initialized. 04:42:24 INFO - Running cycle 1/1 for kraken test... 04:42:24 INFO - TEST-INFO | started process 7016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpul3Fqb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:37 INFO - PROCESS | 7016 | RSS: Main: 186298368 04:42:37 INFO - PROCESS | 7016 | 04:42:39 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53201/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:40 INFO - PROCESS | 7016 | RSS: Main: 191082496 04:42:40 INFO - PROCESS | 7016 | 04:42:43 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53201/tests/kraken/driver.html?testName=audio-dft) 04:42:44 INFO - PROCESS | 7016 | RSS: Main: 191049728 04:42:44 INFO - PROCESS | 7016 | 04:42:47 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53201/tests/kraken/driver.html?testName=audio-fft) 04:42:47 INFO - PROCESS | 7016 | RSS: Main: 186933248 04:42:47 INFO - PROCESS | 7016 | 04:42:50 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53201/tests/kraken/driver.html?testName=audio-oscillator) 04:42:50 INFO - PROCESS | 7016 | RSS: Main: 187215872 04:42:50 INFO - PROCESS | 7016 | 04:42:52 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:53 INFO - PROCESS | 7016 | RSS: Main: 187236352 04:42:53 INFO - PROCESS | 7016 | 04:42:56 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53201/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:57 INFO - PROCESS | 7016 | RSS: Main: 187932672 04:42:57 INFO - PROCESS | 7016 | 04:43:00 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53201/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:01 INFO - PROCESS | 7016 | RSS: Main: 184782848 04:43:01 INFO - PROCESS | 7016 | 04:43:04 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53201/tests/kraken/driver.html?testName=json-parse-financial) 04:43:05 INFO - PROCESS | 7016 | RSS: Main: 186597376 04:43:05 INFO - PROCESS | 7016 | 04:43:06 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:07 INFO - PROCESS | 7016 | RSS: Main: 186703872 04:43:07 INFO - PROCESS | 7016 | 04:43:09 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:10 INFO - PROCESS | 7016 | RSS: Main: 187428864 04:43:10 INFO - PROCESS | 7016 | 04:43:12 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:13 INFO - PROCESS | 7016 | RSS: Main: 188268544 04:43:13 INFO - PROCESS | 7016 | 04:43:15 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:16 INFO - PROCESS | 7016 | RSS: Main: 187547648 04:43:16 INFO - PROCESS | 7016 | 04:43:19 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:20 INFO - PROCESS | 7016 | RSS: Main: 187052032 04:43:20 INFO - PROCESS | 7016 | 04:43:21 INFO - PROCESS | 7016 | Cycle 1(1): loaded http://localhost:53201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53201/tests/kraken/driver.html?testName=ai-astar) 04:43:22 INFO - PROCESS | 7016 | RSS: Main: 188846080 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | __start_tp_report 04:43:22 INFO - PROCESS | 7016 | _x_x_mozilla_page_load 04:43:22 INFO - PROCESS | 7016 | _x_x_mozilla_page_load_details 04:43:22 INFO - PROCESS | 7016 | |i|pagename|runs| 04:43:22 INFO - PROCESS | 7016 | |0;ai-astar;106;114;108;116;116;115;116;115;115;113 04:43:22 INFO - PROCESS | 7016 | |1;audio-beat-detection;171;132;158;181;141;157;158;135;193;135 04:43:22 INFO - PROCESS | 7016 | |2;audio-dft;164;167;171;162;163;163;164;164;163;162 04:43:22 INFO - PROCESS | 7016 | |3;audio-fft;76;76;78;163;76;76;76;76;173;77 04:43:22 INFO - PROCESS | 7016 | |4;audio-oscillator;88;87;137;87;87;88;130;86;87;138 04:43:22 INFO - PROCESS | 7016 | |5;imaging-gaussian-blur;119;117;118;119;118;118;123;119;117;118 04:43:22 INFO - PROCESS | 7016 | |6;imaging-darkroom;146;148;149;146;149;149;147;149;147;151 04:43:22 INFO - PROCESS | 7016 | |7;imaging-desaturate;96;96;96;95;95;95;96;95;96;95 04:43:22 INFO - PROCESS | 7016 | |8;json-parse-financial;65;64;64;69;64;65;64;64;69;64 04:43:22 INFO - PROCESS | 7016 | |9;json-stringify-tinderbox;65;66;65;66;66;72;66;66;65;66 04:43:22 INFO - PROCESS | 7016 | |10;stanford-crypto-aes;83;83;88;90;83;84;85;84;107;89 04:43:22 INFO - PROCESS | 7016 | |11;stanford-crypto-ccm;130;142;135;137;130;130;134;139;141;141 04:43:22 INFO - PROCESS | 7016 | |12;stanford-crypto-pbkdf2;171;171;174;169;172;167;167;170;179;167 04:43:22 INFO - PROCESS | 7016 | |13;stanford-crypto-sha256-iterative;71;67;67;66;69;67;70;67;67;67 04:43:22 INFO - PROCESS | 7016 | __end_tp_report 04:43:22 INFO - PROCESS | 7016 | __start_cc_report 04:43:22 INFO - PROCESS | 7016 | _x_x_mozilla_cycle_collect,1031 04:43:22 INFO - PROCESS | 7016 | __end_cc_report 04:43:22 INFO - PROCESS | 7016 | __startTimestamp1466682202037__endTimestamp 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | ------- Summary: start ------- 04:43:22 INFO - PROCESS | 7016 | Number of tests: 14 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:3.53 (3.1%) stddev-sans-first:2.54 04:43:22 INFO - PROCESS | 7016 | Values: 106.0 114.0 108.0 116.0 116.0 115.0 116.0 115.0 115.0 113.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:158.00 stddev:20.85 (13.2%) stddev-sans-first:21.40 04:43:22 INFO - PROCESS | 7016 | Values: 171.0 132.0 158.0 181.0 141.0 157.0 158.0 135.0 193.0 135.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 04:43:22 INFO - PROCESS | 7016 | Values: 164.0 167.0 171.0 162.0 163.0 163.0 164.0 164.0 163.0 162.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:38.71 (50.9%) stddev-sans-first:40.46 04:43:22 INFO - PROCESS | 7016 | Values: 76.0 76.0 78.0 163.0 76.0 76.0 76.0 76.0 173.0 77.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:87.00 stddev:23.22 (26.7%) stddev-sans-first:24.10 04:43:22 INFO - PROCESS | 7016 | Values: 88.0 87.0 137.0 87.0 87.0 88.0 130.0 86.0 87.0 138.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.71 (1.4%) stddev-sans-first:1.81 04:43:22 INFO - PROCESS | 7016 | Values: 119.0 117.0 118.0 119.0 118.0 118.0 123.0 119.0 117.0 118.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:149.00 stddev:1.60 (1.1%) stddev-sans-first:1.50 04:43:22 INFO - PROCESS | 7016 | Values: 146.0 148.0 149.0 146.0 149.0 149.0 147.0 149.0 147.0 151.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:43:22 INFO - PROCESS | 7016 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:2.04 (3.2%) stddev-sans-first:2.17 04:43:22 INFO - PROCESS | 7016 | Values: 65.0 64.0 64.0 69.0 64.0 65.0 64.0 64.0 69.0 64.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:2.06 (3.1%) stddev-sans-first:2.13 04:43:22 INFO - PROCESS | 7016 | Values: 65.0 66.0 65.0 66.0 66.0 72.0 66.0 66.0 65.0 66.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:7.31 (8.6%) stddev-sans-first:7.56 04:43:22 INFO - PROCESS | 7016 | Values: 83.0 83.0 88.0 90.0 83.0 84.0 85.0 84.0 107.0 89.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:138.00 stddev:4.82 (3.5%) stddev-sans-first:4.61 04:43:22 INFO - PROCESS | 7016 | Values: 130.0 142.0 135.0 137.0 130.0 130.0 134.0 139.0 141.0 141.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.00 stddev:3.74 (2.2%) stddev-sans-first:3.97 04:43:22 INFO - PROCESS | 7016 | Values: 171.0 171.0 174.0 169.0 172.0 167.0 167.0 170.0 179.0 167.0 04:43:22 INFO - PROCESS | 7016 | 04:43:22 INFO - PROCESS | 7016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.24 04:43:22 INFO - PROCESS | 7016 | Values: 71.0 67.0 67.0 66.0 69.0 67.0 70.0 67.0 67.0 67.0 04:43:22 INFO - PROCESS | 7016 | -------- Summary: end -------- 04:43:22 INFO - PROCESS | 7016 | 04:43:23 INFO - TEST-INFO | 7016: exit 0 04:43:23 INFO - TEST-OK | kraken | took 65121ms 04:43:23 INFO - SUITE-END | took 1182s 04:43:23 INFO - Completed test suite (00:19:42) 04:43:23 INFO - javascript benchmark 04:43:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6404.960668087066, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2642.0884794745816, 2651.3106592286026, 2655.747703968123, 2656.2562482504895, 2679.544477438835, 4878.0975519528865, 4915.188993816025, 4935.925961110582, 4976.0, 5048.368953880765, 4902.166631672615, 4907.631927605426, 4916.901661966758, 4925.950740492594, 4952.455229924714, 4467.151241264158, 4500.0, 4597.034622729214, 4624.468186158584, 4646.372739680134, 474.43128343640643, 4455.443069616298, 4521.276595744682, 4524.959259370346, 4556.020455602045, 4552.408186935694, 4582.33556134362, 4605.963658176917, 4610.9308360374625, 4627.606653434462, 4575.359449677047, 4597.678162528624, 4619.653525985531, 4625.444946606395, 4644.651651126179, 4420.270655341865, 4469.910601787946, 4470.687051906368, 4498.932516012263, 4512.548745125494, 4878.780454879504, 4957.107720610289, 5003.724795136266, 5011.699298042129, 5060.797568097271, 5303.522682958553, 5376.569874410077, 5381.461853814626, 5383.4616538346245, 5388.73056347185, 5356.4107948125675, 5365.168398898177, 5369.221462887898, 5389.461053894618, 5422.783088676449, 4981.227909674007, 4984.800607975713, 5007.24891266313, 5013.699178049255, 5039.0929632666475, 5349.411564727877, 5490.121580547093, 5490.203920431515, 5490.945090549123, 5508.91736623951, 5331.067063263991, 5331.840044798662, 5338.225957236179, 5341.4925582069645, 5395.109806881821, 5414.458554144633, 5424.132138857843, 5442.700651464128, 5451.155070964007, 5464.7814087436855, 5137.587163530059, 5301.913107812889, 5344.732763361816, 5365.517103460707, 5390.245365648812, 5361.142217245222, 5384.138537833927, 5402.810901618424, 5406.405295417501, 5410.48600382963, 4600.700954437951, 4601.792919318572, 4613.792379342937, 4620.768961551977, 4667.393238878924, 3872.9419058714143, 3881.573026967031, 3883.417487376916, 3916.96083039166, 3944.467496887941, 4577.244754615451, 4589.2198326284615, 4608.308753686973, 4653.697509661861, 4658.95341046592, 5301.257823904656, 5422.620416570881, 5453.263809385682, 5463.72681365938, 5496.900619876041, 4568.520305367889, 4578.679492435497, 4595.655325850575, 4608.769561521977, 4611.1930412177735, 4782.139214941274, 4796.088743138793, 4841.903161936812, 4843.660943733976, 4891.168501354707, 4920.8769780755765, 5008.298838162733, 5011.834877408581, 5023.799048038038, 5079.517445842565, 5379.838604841861, 5395.514403703685, 5411.458854114557, 5423.403425623257, 5459.69971651563, 5019.447860735243, 5026.045051440215, 5029.968856384506, 5037.345145131109, 5038.093143234107, 5214.582833373397, 5233.293505376725, 5267.3152490176035, 5287.0, 5305.761240744098, 5398.892022159614, 5402.108652072364, 5415.972920135374, 5417.593680474059, 5453.15476101205, 5234.528892399702, 5258.921116183337, 5269.28864603289, 5273.077211488051, 5317.962997215506, 5102.4897510248675, 5133.255677926605, 5162.070827251131, 5212.635115541876, 5231.790728370823, 5092.719900405513, 5106.923396148986, 5136.691798492103, 5142.254373115802, 5156.587473002226, 5254.632175747661, 5262.842114736564, 5265.2891859599995, 5271.0, 5281.419043905091, 5011.198208286657, 5072.137736584863, 5128.692278463304, 5162.354705661793, 5185.714785686823], "value": 4873.3179030798165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.5324394398843, 571.6570057965218, 589.6904125334199, 596.5764307341788, 612.8927437698403, 36018.45972310418, 36548.634513654855, 39230.0, 39457.408138877865, 39622.80188599053, 39678.404823927594, 40279.39580906289, 40472.39291410624, 40604.79697601508, 40725.59274407255, 7834.490758100734, 7911.802204944894, 7938.523688578675, 7953.522788632672, 7953.840923181533, 7459.440541959348, 7868.449208555404, 7913.564753938531, 7917.168697286788, 7924.3660507159575, 7891.250331218525, 7935.127136015034, 7941.08677502086, 7977.720779772709, 7978.962734844462, 7851.5681637509915, 7872.960635196816, 7908.723194688158, 7917.247861453182, 7932.603369831514, 7837.647305871193, 7850.882236766453, 7876.960615196945, 7889.0, 7903.525788452711, 38369.61630383688, 38729.41905871414, 38744.806275968724, 38897.41653875194, 38955.41566876499, 3358.4794356874722, 3771.181168976591, 3778.9811050944845, 3790.431435284702, 3882.475865758143, 29199.124026279245, 29219.85390073036, 29594.556081658793, 29849.850750746107, 30663.38673226545, 3493.179102910814, 3503.5795704515367, 3530.3998320285614, 3536.8585256589704, 3611.0611241077245, 257437.0, 257785.99999999814, 258025.0, 259089.0, 259234.0, 31892.84053579717, 32891.50662740061, 33050.0, 34433.82783086068, 49889.25166122511, 34114.0, 34115.0, 34137.65862341395, 34501.0, 34626.0, 12481.75036499265, 12620.81068783969, 12632.747345053047, 12646.114771966058, 12702.745945081047, 10950.06924411418, 11136.554537818558, 11185.32888026721, 11207.775844483065, 11347.319160850375, 7906.0, 7968.322692571081, 8065.475744076616, 8065.798355041171, 8101.716439924574, 3103.379324135182, 3131.9843400783307, 3137.8431078446442, 3166.6200055993427, 3168.5405616185526, 871.9825603487894, 892.6474042753076, 893.271983333581, 975.673149494913, 992.7666998255404, 27965.0, 28009.0, 28029.0, 28440.146795596163, 28827.7117228825, 930.5672862119147, 941.6139382853135, 949.1552518258756, 971.8979507151647, 1010.8736407949007, 14832.18422986746, 15078.246087695572, 15098.320575573905, 15200.239988000556, 15306.540803775904, 374688.0, 377986.0, 378545.0, 379117.0, 382221.0, 49201.753991229816, 49230.50769492331, 49611.503884961414, 49738.75130624396, 49793.75103124534, 1165.3765235599083, 1172.1501911114374, 1194.50428072349, 1200.5197920831563, 1202.8857258560597, 25276.0, 27586.172414827586, 27726.306842329104, 27806.721932780412, 28101.57847632328, 43825.78087109544, 43901.0, 44027.77986110049, 44098.338524922794, 44099.559004409544, 332286.0, 332419.0, 333140.0, 333149.0, 333202.0, 24892.128775492773, 25730.0, 25809.096681616054, 25993.22020339393, 26181.345466363495, 38776.80611596924, 41048.79475602603, 41990.58009419867, 42270.78864605657, 42380.788096059325, 36336.818315908255, 36839.26321473609, 37132.25735485329, 37157.81421092986, 37354.43968340423, 36616.81691591525, 36870.63129368672, 36995.8150209258, 37033.25933481262, 37083.0, 34452.53880662202, 35352.469712954844, 35592.288154237285, 36180.27639447249, 36205.63794362128, 31112.844435777675, 32273.33498390691, 32467.18832029218, 32605.0, 32664.51003235001, 24894.502109958063, 25061.373465663506, 25314.546537011604, 25337.239882803544, 25390.0], "value": 16499.119764244293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.34633871217324, 376.3075940269904, 376.992460150797, 391.12973633665115, 396.910695093604, 15953.282102305395, 16156.353745850167, 17296.394626188103, 17299.221535030923, 17327.22027508762, 14591.489297874576, 16214.189290535456, 17130.400435984742, 17175.0, 17279.913600432013, 4592.540745925414, 4791.544803243703, 4829.661923665345, 4830.541098595628, 4846.273059041137, 3470.6182319944787, 5209.661372010826, 5524.502794748471, 5542.2517960075475, 5549.223108764776, 5537.916931246014, 5550.77796888124, 5559.054960656677, 5579.888402231953, 5615.298087739033, 6019.668918209497, 6122.418370254819, 6133.907991380132, 6152.292486364081, 6177.196964394645, 5431.51116399522, 5449.4005659377435, 5464.9453505464835, 5468.6171967962255, 5477.616566840323, 12440.377981100908, 12645.304508252042, 12803.359832008455, 12808.103432759617, 16293.91853040739, 1898.6202759448165, 1923.6537423263808, 1979.5546002149545, 1997.131247907165, 2059.1454546363393, 9252.259819214514, 9456.57445414958, 9567.808643827155, 10428.426436545988, 13030.153040052366, 1781.946541603754, 1798.4514723009609, 1836.4766041678058, 1839.4481655503296, 1865.4590168851016, 62573.37426625766, 62789.99999999954, 63702.68148659274, 64245.357546424406, 64354.0, 9801.647604574851, 10040.397576145455, 10217.18262538995, 10322.741931451774, 10464.110550603284, 14084.0, 14124.364403601863, 14160.734282514748, 14177.503787367392, 14213.64465888361, 7275.67259473325, 7356.705731770776, 7394.889076663854, 7478.177400485943, 7489.475736698488, 6837.735019021397, 6927.168739751262, 6945.89581156283, 6963.303669632996, 7080.858382832314, 4386.254336762694, 4414.779261037, 4445.711028783118, 4446.510883802779, 4546.499885012646, 1680.899146051241, 1744.322465016194, 1872.5318670332417, 1880.7366968624403, 1881.8212269834344, 802.6107337941094, 831.8170002599419, 866.467122719523, 925.287528602972, 949.9645386528717, 16696.916515417346, 17058.573535661708, 17059.65880682404, 17412.91293543524, 17414.738778918327, 860.6299291304799, 870.2950610005915, 885.7696998780364, 898.1198425542874, 940.722486866376, 9376.249900007982, 9671.564779584936, 9718.514074296258, 9813.460259685644, 9873.60505579783, 387850.0, 388860.0, 391214.0, 399309.0, 400193.0, 76876.9606134535, 81037.18962810414, 81410.0, 81597.0, 84694.5765271182, 906.619219927632, 917.3440989692402, 927.2906226736552, 931.8788557487484, 936.9156775890202, 15278.847211527742, 15510.457134000257, 15697.529074127795, 15827.446039389028, 15916.965397249141, 35986.28027439489, 36869.0, 37465.0, 37634.43548346722, 38362.0, 51306.0, 52335.73832130815, 52583.21125183202, 52664.0, 53300.73349633227, 6720.764773232913, 7072.0, 7289.052423184952, 7317.0487836580905, 7319.45104117204, 11080.833787493355, 11483.885161148282, 11818.0, 12205.572804951784, 12234.388280586114, 10105.949470252895, 10272.33229840058, 10290.485475726333, 10400.323978941344, 10402.427866467417, 9486.383385080224, 10302.948485257826, 10430.895691042992, 10448.843267350843, 10519.631812886511, 10613.681589552325, 10643.308184967953, 10784.08335291509, 10869.184811139354, 10875.564977401133, 6682.298358672269, 7028.9297107030325, 7838.725644602411, 8115.878261825959, 8124.22819832115, 9982.650607228712, 10515.526801294112, 10528.157747380345, 10533.42066186367, 10733.946330268298], "value": 8201.954130653165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.5198554513145, 1392.728417958498, 1461.817272840895, 1627.3571939084054, 1688.9915550422247, 6763.458923286137, 7526.473146879721, 7860.646270917809, 8196.180381961809, 8197.180281971807, 7706.961465192666, 7823.92176078239, 7949.721759738411, 7953.840923181548, 7966.760997170094, 2186.8250539956766, 2221.655643375271, 2225.643896976484, 2227.1536816009975, 2227.9108835646553, 2153.6446486329814, 2177.042101475354, 2197.055266235518, 2205.106931692667, 2211.5355775287208, 2163.8485306028583, 2174.652055671093, 2181.4982554012586, 2186.365953873375, 2189.321310393783, 2150.956980860382, 2160.8487405881515, 2161.4056134562966, 2164.9783502164933, 2167.41479800453, 2123.5115923337567, 2132.86136401135, 2141.0472339808794, 2150.161437039556, 2164.14516266074, 7935.246151615645, 7938.722144724907, 7988.121306656263, 7989.920100798976, 7994.680212791482, 4566.1552612766745, 4703.3885594872445, 4713.505081966413, 4716.363290955712, 4722.362481065046, 2972.628421447319, 3083.167544762924, 3113.8443077846246, 3143.245621050954, 3163.351512939842, 902.4179404284265, 925.0887875442684, 938.6104766521885, 949.3307218411072, 953.423178976716, 10746.462676866126, 10796.892031079668, 10813.783724325549, 10834.945825270903, 10844.13246940243, 4241.681873859473, 4315.352697095461, 4332.566743325642, 4450.0, 4452.48796388413, 9176.770580735534, 9201.677941272023, 9201.723948281562, 9205.907940920639, 9242.306826988002, 4764.14245435818, 4788.880277993078, 4803.543663351976, 4810.807567697253, 4826.541478559531, 3798.9810050950123, 4261.360795880581, 4297.935530967038, 4359.694821362475, 4459.754713490789, 3641.435577485494, 3699.963000370016, 3737.4206997915367, 3769.8869033929027, 3935.2916475034767, 1206.240068756695, 1211.061427393777, 1216.1912328301757, 1218.695326168458, 1226.3132645718426, 788.5741699482215, 795.5783434779576, 798.66456088443, 800.8838718385917, 807.2492581898773, 4992.001599680006, 5003.149464591028, 5033.345665063518, 5111.514406131411, 5147.639665223398, 405.7220803749441, 412.12012353625227, 417.64917469325303, 423.66530440951306, 436.79034063648993, 3430.8627654893526, 3488.7383446241124, 3490.127468132967, 3494.1264683829045, 3514.2093029068765, 9203.0, 9292.953535232416, 9532.714018579454, 9561.808763824685, 9564.856527151958, 9347.158755712018, 9365.578548965314, 9395.436273823592, 9400.435973841591, 9421.104995025462, 7070.080889484334, 7255.746048888263, 7321.304476074764, 7330.926690733131, 7341.559506429739, 4764.118638051971, 4835.226363781778, 4852.2479015752615, 4959.603231741524, 4999.525045120708, 8404.621792019252, 8803.779905502413, 9017.323700722603, 9018.458892466473, 9185.816283674423, 9225.86161207569, 9287.396319239228, 9398.389104708172, 9424.104710052809, 9473.005334439784, 6234.937650623436, 6991.3008699131715, 7128.0, 7152.24901385347, 7426.443016773872, 7457.0, 7688.231176882267, 7690.615469226628, 7750.379969602531, 7756.3019328260725, 6790.898136528055, 6851.794446166623, 6931.4108300795, 7096.680649370687, 7117.822054448473, 6884.208316043719, 6914.412274956685, 6931.2375638678695, 6966.825829354307, 6979.371856532936, 6022.1870047543025, 6086.786962456293, 6098.573099882966, 6113.14415981754, 6137.048757442603, 4446.221911165598, 4493.528179541101, 4514.187446259705, 4515.571020753023, 4536.88657783558, 4437.755923424243, 4548.20406428867, 4567.680262381601, 4602.930956035595, 4614.823220078858], "value": 4080.8249728487617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.63932002956386, 303.1375736030992, 312.8498320806014, 312.9217695576106, 313.3279116295546, 5013.470891378128, 5060.392752869651, 5195.0, 5228.8692782680455, 5254.868628284295, 4994.200927851544, 5023.648344615878, 5117.104506711329, 5124.385073791141, 5157.58739300856, 4015.2973229684835, 4026.2953983052994, 4028.1742242840296, 4028.8791336259815, 4044.6966477514156, 3939.1924655445564, 4035.61661642145, 4043.1913617276514, 4047.8380864765372, 4061.2689715851134, 3933.547642021161, 3984.581618930014, 3992.800359982004, 4012.0, 4020.738651987626, 3990.940135897964, 3991.3214753491975, 3991.600839916014, 3997.8600748973645, 4040.949353168168, 3553.614090504705, 3562.020444377817, 3571.839152275521, 3576.247638657065, 3587.0, 4856.660033797601, 4997.775100120467, 5015.84952451427, 5025.246213068032, 5114.721319670082, 4568.908621827545, 4574.176648203322, 4629.65277604181, 4639.448303433132, 4648.442186937556, 5362.973185134088, 5371.435999220064, 5387.0, 5389.892202155974, 5397.757100930428, 3729.9067523311865, 3844.8654297099465, 3875.4380614810975, 3878.3019056569806, 3903.551091624471, 5518.2826232589905, 5531.419200983879, 5595.272614560081, 5602.355729091125, 5672.149177623348, 3944.36890097583, 3970.9278494806817, 3978.8209530571194, 3979.1643754811234, 3981.163955569305, 3807.3527500325013, 4037.596240375939, 4039.5758445363404, 4045.777482238505, 4064.8577299794365, 4507.729536227836, 4533.002739397327, 4558.225101732647, 4559.863204103882, 4587.564181402761, 5356.598255130881, 5363.356397232357, 5382.327209098863, 5411.864703382447, 5424.159255315353, 1314.822498962647, 1384.6261509392407, 1416.6812467194798, 1423.2954687429788, 1425.7861320801962, 909.6361455417886, 918.9799322751741, 928.1924725488868, 933.2347475070512, 942.1144124522926, 4175.373693945871, 4193.937090943638, 4196.685248606367, 4207.664746065962, 4223.345381465878, 4879.316895634614, 4884.291777692215, 4888.9755551222015, 4931.087748766489, 4977.203647416396, 4117.044403908179, 4188.60208280219, 4200.626645945032, 4206.305959516707, 4218.6414154797185, 2504.8747562621797, 2658.670664667666, 2664.706882242952, 2665.160474450542, 2668.8799004044863, 4566.4748553916725, 4575.6044406455685, 4584.587387135174, 4616.699914505546, 4645.674802763841, 4923.873340428782, 4987.628402189427, 5009.699418034929, 5010.845336505337, 5029.949700503022, 4278.72188307759, 4564.7032942858605, 4591.540845915381, 4610.170169369479, 4616.584507394351, 4848.272759086165, 4859.0, 4862.343583616166, 4888.877778055577, 4916.680415772963, 4792.760361981817, 4797.784099715452, 4799.3760811094335, 4817.373741413594, 4862.124817532878, 4420.381146639537, 4589.518100599389, 4599.770011499479, 4611.262198048296, 4665.720056796467, 3642.8107676172613, 3659.9817000914827, 3671.980410774117, 3679.374506333876, 3711.777293362407, 4926.556609905126, 4957.553820156203, 4978.900421991612, 4992.700437973734, 5318.361796584435, 5217.921731173959, 5458.235846981346, 5463.262459567907, 5474.069408200695, 5488.81990372072, 5423.430539793265, 5470.343558772973, 5472.261244731911, 5474.2609747683555, 5478.397376288684, 5115.74421278942, 5291.1798671206025, 5293.708846013506, 5324.0, 5348.090824559757, 5435.184722291688, 5438.728063596884, 5440.483154100354, 5466.808661696821, 5467.425920278313, 5228.37259528859, 5302.814401495929, 5312.910853275147, 5361.463853614608, 5370.436104209158], "value": 3912.323255750463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.9494440444764, 685.4927353758218, 703.3353480960494, 743.4869939741578, 757.4281417529766, 12773.808392874103, 13472.595822125328, 13477.797833032513, 13501.864981350183, 13544.255065971367, 12499.750004999894, 13166.27585482798, 13190.34048297586, 13203.933980330085, 13218.93390533046, 616.0758861707438, 760.6424980259269, 776.926192011758, 787.9172686867882, 789.8222899847545, 768.6387397922967, 770.0682174568778, 770.8573913825932, 772.0349563046192, 773.8993930788989, 831.733845169546, 834.1950018232404, 834.8163404051099, 834.8789425533294, 835.0105125426359, 825.4840724547158, 828.6643909216776, 830.9861968398544, 831.0110967948152, 831.6257684042145, 607.5898768331402, 609.6189881324173, 609.6524980760968, 610.1762620462384, 610.4719417703654, 12664.17682850621, 12693.11148219625, 12762.361881905868, 12767.23396596198, 12830.615081547476, 12642.178258413174, 13060.934695326558, 13353.933230333883, 13454.798178027337, 13531.932340338333, 10470.685879423554, 10564.15486761065, 10802.351858888413, 10818.134549236122, 10998.560057597686, 3400.1159698478573, 3462.0652423845672, 3467.601225859033, 3485.494603282535, 3492.1269682579355, 63639.0, 64112.679436602986, 64702.67648661727, 65150.674246628936, 65384.0, 10553.84169237462, 10564.894351056544, 10746.73133171677, 10930.508127134299, 11059.281146725438, 20824.27115050966, 20842.68735968962, 20870.26954056631, 20934.37196884096, 20938.267160649306, 7113.181984071898, 7206.7117315306805, 7226.096737907762, 7280.781576552712, 7356.301151390609, 3623.3146361007707, 3782.5460944686815, 3841.5582208045876, 3844.3464611016193, 3964.72246942717, 3055.724984751383, 3169.904902852918, 3177.4757165067504, 3177.920551986219, 3180.80915145092, 550.9889802203934, 574.9770009199668, 579.6058680097574, 587.806024012075, 588.632104934416, 613.8772245550907, 622.483338828771, 643.5109316919176, 658.1937127019459, 659.0904551718597, 8241.83516329682, 8381.539015354214, 8434.24091831738, 8713.25937295337, 8803.119688031275, 514.6294667839225, 530.615303904666, 572.653544605516, 586.9288548399188, 623.3423737956409, 3471.6354782747953, 3571.196480791801, 3637.0725465006253, 3736.8505259789304, 4334.891627709332, 52705.736471317396, 53804.192937105974, 54097.72951135219, 54246.0, 63145.684271579266, 78338.60830695924, 80803.5959820209, 81449.59275203587, 81783.0, 82981.58509207415, 70028.2997170032, 73532.63233683797, 73850.89223661649, 74109.0, 74402.0, 8121.201882226635, 8148.185181481805, 8234.547099909563, 8276.255137037455, 8406.453580517247, 41175.794121029205, 41683.19496078113, 41916.0, 42407.15185696207, 42523.574764251964, 54447.72776136253, 61753.0, 62657.373426265156, 63516.364836351044, 63664.68167659132, 10021.0, 10093.394396336244, 10187.643432479828, 10429.582816687247, 10557.419341936267, 10126.291159618757, 10285.177185824967, 10976.835347469634, 11053.613123540637, 12163.878361216275, 12155.0, 12258.448369823558, 12719.682007949876, 12728.23630582168, 12869.420876060787, 12014.939925300318, 12143.249924451426, 12154.453049612612, 12545.372731363577, 12757.74484510286, 11499.8275025873, 11704.414779260833, 11899.405029748652, 12620.0, 12881.291528965998, 10066.597336106473, 10333.173346132442, 10696.89303106959, 10794.892051079389, 10898.455077245948, 9717.9028209717, 10167.949160254151, 10294.845577316497, 10556.947215263874, 10562.31344962575], "value": 6556.439232028094, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 108.0, 116.0, 116.0, 115.0, 116.0, 115.0, 115.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 132.0, 158.0, 181.0, 141.0, 157.0, 158.0, 135.0, 193.0, 135.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 171.0, 162.0, 163.0, 163.0, 164.0, 164.0, 163.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 163.0, 76.0, 76.0, 76.0, 76.0, 173.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 137.0, 87.0, 87.0, 88.0, 130.0, 86.0, 87.0, 138.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 119.0, 118.0, 118.0, 123.0, 119.0, 117.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 149.0, 146.0, 149.0, 149.0, 147.0, 149.0, 147.0, 151.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 69.0, 64.0, 65.0, 64.0, 64.0, 69.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 72.0, 66.0, 66.0, 65.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 88.0, 90.0, 83.0, 84.0, 85.0, 84.0, 107.0, 89.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 142.0, 135.0, 137.0, 130.0, 130.0, 134.0, 139.0, 141.0, 141.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 174.0, 169.0, 172.0, 167.0, 167.0, 170.0, 179.0, 167.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 66.0, 69.0, 67.0, 70.0, 67.0, 67.0, 67.0], "value": 67.8, "unit": "score"}]}]} 04:43:23 INFO - Return code: 0 04:43:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:23 ERROR - # TBPL SUCCESS # 04:43:23 INFO - Running post-action listener: _resource_record_post_action 04:43:23 INFO - ##### 04:43:23 INFO - ##### Finished run-tests step (success) 04:43:23 INFO - ##### 04:43:23 INFO - Running post-run listener: _resource_record_post_run 04:43:23 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 12288; Write bytes: 543981568; Read time: 504; Write time: 875536 04:43:23 INFO - TinderboxPrint: CPU usage
13.6% 04:43:23 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 504 04:43:23 INFO - TinderboxPrint: I/O write bytes / time
543,981,568 / 875,536 04:43:23 INFO - TinderboxPrint: CPU idle
8,269.9 (86.4%) 04:43:23 INFO - TinderboxPrint: CPU user
1,241.2 (13.0%) 04:43:23 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:23 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 246288384; Read time: 268; Write time: 509940 04:43:23 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 8192; Write bytes: 291115008; Read time: 236; Write time: 359064 04:43:24 INFO - Running post-run listener: _upload_blobber_files 04:43:24 INFO - Blob upload gear active. 04:43:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:24 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 04:43:24 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'] 04:43:24 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 04:43:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:43:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:25 INFO - (blobuploader) - INFO - Done attempting. 04:43:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:29 INFO - (blobuploader) - INFO - Done attempting. 04:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:30 INFO - (blobuploader) - INFO - Done attempting. 04:43:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:30 INFO - Return code: 0 04:43:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3c6f880b0c3506d54112b68e9544f21835297ea9c181299705f9161b4d8859864bffcb96897a741e04a8d867c1f0683803770659f7b58486620302e98ae3f01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43d7053401d1a8c53a064caf851e7248068e847a49fb513038885ef2b8b96b88a7b8337dade33bf01ffa3f1cc818fd4f7be991f1057dd1bf55a710c8c27c897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcf9ccc48f16aa211b0f03f8be4b22ad2fe7099e2eaa0be9d596ff2df02c0fc203e7a0e6bb644eddb92969138a91db69b47176ba74a07a80b76b5906d77fedff"} 04:43:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:30 INFO - Contents: 04:43:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3c6f880b0c3506d54112b68e9544f21835297ea9c181299705f9161b4d8859864bffcb96897a741e04a8d867c1f0683803770659f7b58486620302e98ae3f01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43d7053401d1a8c53a064caf851e7248068e847a49fb513038885ef2b8b96b88a7b8337dade33bf01ffa3f1cc818fd4f7be991f1057dd1bf55a710c8c27c897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcf9ccc48f16aa211b0f03f8be4b22ad2fe7099e2eaa0be9d596ff2df02c0fc203e7a0e6bb644eddb92969138a91db69b47176ba74a07a80b76b5906d77fedff"} 04:43:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:30 INFO - Copying logs to upload dir... 04:43:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.148461 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-06-23 04:43:29.816859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:43:29.819913) ========= 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=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3c6f880b0c3506d54112b68e9544f21835297ea9c181299705f9161b4d8859864bffcb96897a741e04a8d867c1f0683803770659f7b58486620302e98ae3f01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43d7053401d1a8c53a064caf851e7248068e847a49fb513038885ef2b8b96b88a7b8337dade33bf01ffa3f1cc818fd4f7be991f1057dd1bf55a710c8c27c897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcf9ccc48f16aa211b0f03f8be4b22ad2fe7099e2eaa0be9d596ff2df02c0fc203e7a0e6bb644eddb92969138a91db69b47176ba74a07a80b76b5906d77fedff"} build_url:https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/dgpJl358Sd6I5MKNdveJ0w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3c6f880b0c3506d54112b68e9544f21835297ea9c181299705f9161b4d8859864bffcb96897a741e04a8d867c1f0683803770659f7b58486620302e98ae3f01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43d7053401d1a8c53a064caf851e7248068e847a49fb513038885ef2b8b96b88a7b8337dade33bf01ffa3f1cc818fd4f7be991f1057dd1bf55a710c8c27c897", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bcf9ccc48f16aa211b0f03f8be4b22ad2fe7099e2eaa0be9d596ff2df02c0fc203e7a0e6bb644eddb92969138a91db69b47176ba74a07a80b76b5906d77fedff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 04:43:29.846099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:43:29.846665) ========= 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=8783db0840cc980e80bb0bd400000236-1466679920.92320-837559680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 04:43:29.932255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:43:29.932718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 04:43:29.933412) ========= ========= Total master_lag: 0.19 =========