builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1465365519.16 results: success (0) buildid: 20160607203013 builduid: cbad0c3de0f74bd9a62abdbc5329ba3e revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.159323) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.159995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.160259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.211000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.211257) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 22:58:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.5M=0s 2016-06-07 22:58:39 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094066 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.325660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.325938) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:39.382767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 22:58:39.383125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7b31be0a19ae5413db3e10ad4e5251cac84b08d --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 a7b31be0a19ae5413db3e10ad4e5251cac84b08d --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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 22:58:39,570 truncating revision to first 12 chars 2016-06-07 22:58:39,570 Setting DEBUG logging. 2016-06-07 22:58:39,570 attempt 1/10 2016-06-07 22:58:39,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7b31be0a19a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 22:58:40,223 unpacking tar archive at: fx-team-a7b31be0a19a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.992986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 22:58:40.390273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.390613) ========= script_repo_revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.391004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.391293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 22:58:40.401291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-07 22:58:40.401578) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:40 INFO - MultiFileLogger online at 20160607 22:58:40 in /builds/slave/test 22:58:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:58:40 INFO - {'append_to_log': False, 22:58:40 INFO - 'base_work_dir': '/builds/slave/test', 22:58:40 INFO - 'blob_upload_branch': 'Fx-Team', 22:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:58:40 INFO - 'branch': 'Fx-Team', 22:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:40 INFO - 'config_files': ('talos/linux_config.py',), 22:58:40 INFO - 'default_actions': ('clobber', 22:58:40 INFO - 'read-buildbot-config', 22:58:40 INFO - 'download-and-extract', 22:58:40 INFO - 'populate-webroot', 22:58:40 INFO - 'create-virtualenv', 22:58:40 INFO - 'install', 22:58:40 INFO - 'run-tests'), 22:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:40 INFO - 'download_minidump_stackwalk': True, 22:58:40 INFO - 'download_symbols': 'ondemand', 22:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:40 INFO - 'installer_path': 'installer.exe', 22:58:40 INFO - 'log_level': 'info', 22:58:40 INFO - 'log_name': 'talos', 22:58:40 INFO - 'log_to_console': True, 22:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:40 INFO - 'opt_config_files': (), 22:58:40 INFO - 'pip_index': False, 22:58:40 INFO - 'sps_profile': False, 22:58:40 INFO - 'sps_profile_interval': 0, 22:58:40 INFO - 'suite': 'dromaeojs-e10s', 22:58:40 INFO - 'system_bits': '32', 22:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:40 INFO - 'title': 'talos-linux64-ix-011', 22:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:40 INFO - 'use_talos_json': True, 22:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:40 INFO - 'work_dir': 'build'} 22:58:40 INFO - ##### 22:58:40 INFO - ##### Running clobber step. 22:58:40 INFO - ##### 22:58:40 INFO - Running pre-action listener: _resource_record_pre_action 22:58:40 INFO - Running main action method: clobber 22:58:40 INFO - rmtree: /builds/slave/test/build 22:58:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:58:41 INFO - Running post-action listener: _resource_record_post_action 22:58:41 INFO - ##### 22:58:41 INFO - ##### Finished clobber step (success) 22:58:41 INFO - ##### 22:58:41 INFO - ##### 22:58:41 INFO - ##### Running read-buildbot-config step. 22:58:41 INFO - ##### 22:58:41 INFO - Running pre-action listener: _resource_record_pre_action 22:58:41 INFO - Running main action method: read_buildbot_config 22:58:41 INFO - Using buildbot properties: 22:58:41 INFO - { 22:58:41 INFO - "project": "", 22:58:41 INFO - "product": "firefox", 22:58:41 INFO - "script_repo_revision": "production", 22:58:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:58:41 INFO - "repository": "", 22:58:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:58:41 INFO - "buildid": "20160607203013", 22:58:41 INFO - "pgo_build": "True", 22:58:41 INFO - "basedir": "/builds/slave/test", 22:58:41 INFO - "buildnumber": 822, 22:58:41 INFO - "slavename": "talos-linux64-ix-011", 22:58:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:58:41 INFO - "platform": "ubuntu64_hw", 22:58:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:58:41 INFO - "branch": "fx-team", 22:58:41 INFO - "repo_path": "integration/fx-team", 22:58:41 INFO - "revision": "a7b31be0a19ae5413db3e10ad4e5251cac84b08d", 22:58:41 INFO - "stage_platform": "linux64-pgo", 22:58:41 INFO - "builduid": "cbad0c3de0f74bd9a62abdbc5329ba3e", 22:58:41 INFO - "slavebuilddir": "test" 22:58:41 INFO - } 22:58:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:58:41 INFO - Running post-action listener: _resource_record_post_action 22:58:41 INFO - ##### 22:58:41 INFO - ##### Finished read-buildbot-config step (success) 22:58:41 INFO - ##### 22:58:41 INFO - ##### 22:58:41 INFO - ##### Running download-and-extract step. 22:58:41 INFO - ##### 22:58:41 INFO - Running pre-action listener: _resource_record_pre_action 22:58:41 INFO - Running main action method: download_and_extract 22:58:41 INFO - mkdir: /builds/slave/test/build/tests 22:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:41 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:46 INFO - Downloaded 1361 bytes. 22:58:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:58:46 INFO - Using the following test package requirements: 22:58:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:58:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'jsshell-linux-x86_64.zip'], 22:58:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:46 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:49 INFO - Downloaded 24447005 bytes. 22:58:49 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'] 22:58:49 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 22:58:50 INFO - Return code: 0 22:58:50 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 22:58:50 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')]} 22:58:50 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:52 INFO - Downloaded 24447005 bytes. 22:58:52 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'] 22:58:52 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 22:58:54 INFO - Return code: 0 22:58:54 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')]} 22:58:54 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:55 INFO - Downloaded 10833369 bytes. 22:58:55 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'] 22:58:55 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 22:58:55 INFO - Return code: 0 22:58: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')]} 22:58:55 INFO - https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:58:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:58:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEi06RDARjWL9aVedZ5jtQ/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 22:58:57 INFO - Downloaded 59190267 bytes. 22:58:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:58:57 INFO - mkdir: /builds/slave/test/properties 22:58:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:58:57 INFO - Writing to file /builds/slave/test/properties/build_url 22:58:57 INFO - Contents: 22:58:57 INFO - build_url:https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:58:57 INFO - Running post-action listener: _resource_record_post_action 22:58:57 INFO - Running post-action listener: set_extra_try_arguments 22:58:57 INFO - ##### 22:58:57 INFO - ##### Finished download-and-extract step (success) 22:58:57 INFO - ##### 22:58:57 INFO - ##### 22:58:57 INFO - ##### Running populate-webroot step. 22:58:57 INFO - ##### 22:58:57 INFO - Running pre-action listener: _resource_record_pre_action 22:58:57 INFO - Running main action method: populate_webroot 22:58:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:57 INFO - '--tppagecycles', 22:58:57 INFO - '7'], 22:58:57 INFO - 'tests': ['tsvgm']}}, 22:58:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:58:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:58:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:58:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['damp', 'tps']}, 22:58:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'tests': ['damp', 'tps']}, 22:58:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['dromaeo_dom']}, 22:58:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'other-e10s': {'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['a11yr', 22:58:57 INFO - 'ts_paint', 22:58:57 INFO - 'tpaint', 22:58:57 INFO - 'sessionrestore', 22:58:57 INFO - 'sessionrestore_no_auto_restore', 22:58:57 INFO - 'tabpaint']}, 22:58:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['tsvgx', 22:58:57 INFO - 'tsvgr_opacity', 22:58:57 INFO - 'tart', 22:58:57 INFO - 'tscrollx', 22:58:57 INFO - 'cart']}, 22:58:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:58:57 INFO - 'tsvgr_opacity', 22:58:57 INFO - 'tart', 22:58:57 INFO - 'tscrollx', 22:58:57 INFO - 'cart']}, 22:58:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'talos_options': ['--disable-e10s'], 22:58:57 INFO - 'tests': ['tp5o']}, 22:58:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'tests': ['tp5o']}, 22:58:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'talos_options': ['--disable-e10s', 22:58:57 INFO - '--xperf_path', 22:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:57 INFO - 'tests': ['tp5n']}, 22:58:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:57 INFO - 'talos_options': ['--xperf_path', 22:58:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:57 INFO - 'tests': ['tp5n']}}, 22:58:57 INFO - 'talos.zip': {'path': '', 22:58:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:57 INFO - Running post-action listener: _resource_record_post_action 22:58:57 INFO - ##### 22:58:57 INFO - ##### Finished populate-webroot step (success) 22:58:57 INFO - ##### 22:58:57 INFO - ##### 22:58:57 INFO - ##### Running create-virtualenv step. 22:58:57 INFO - ##### 22:58:57 INFO - Running pre-action listener: _resource_record_pre_action 22:58:57 INFO - Running main action method: create_virtualenv 22:58:57 INFO - Creating virtualenv /builds/slave/test/build/venv 22:58:57 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 22:58:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:57 INFO - Using real prefix '/usr' 22:58:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:58:58 INFO - Installing distribute.............................................................................................................................................................................................done. 22:59:00 INFO - Installing pip.................done. 22:59:00 INFO - Return code: 0 22:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:59:00 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')]} 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:00 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')]} 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:00 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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:00 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 22:59:00 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 22:59:00 INFO - Using env: {'DISPLAY': ':0', 22:59:00 INFO - 'HOME': '/home/cltbld', 22:59:00 INFO - 'LANG': 'en_US.UTF-8', 22:59:00 INFO - 'LANGUAGE': 'en_US:en', 22:59:00 INFO - 'LOGNAME': 'cltbld', 22:59:00 INFO - 'MAIL': '/var/mail/cltbld', 22:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:00 INFO - 'MOZ_NO_REMOTE': '1', 22:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:00 INFO - 'NO_EM_RESTART': '1', 22:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:00 INFO - 'PWD': '/builds/slave/test', 22:59:00 INFO - 'SHELL': '/bin/bash', 22:59:00 INFO - 'SHLVL': '1', 22:59:00 INFO - 'TERM': 'linux', 22:59:00 INFO - 'TMOUT': '86400', 22:59:00 INFO - 'USER': 'cltbld', 22:59:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:00 INFO - '_': '/tools/buildbot/bin/python'} 22:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:00 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 22:59:00 INFO - Cleaning up... 22:59:00 INFO - Return code: 0 22:59:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:59:00 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')]} 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:00 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')]} 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:00 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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:00 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 22:59:00 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 22:59:00 INFO - Using env: {'DISPLAY': ':0', 22:59:00 INFO - 'HOME': '/home/cltbld', 22:59:00 INFO - 'LANG': 'en_US.UTF-8', 22:59:00 INFO - 'LANGUAGE': 'en_US:en', 22:59:00 INFO - 'LOGNAME': 'cltbld', 22:59:00 INFO - 'MAIL': '/var/mail/cltbld', 22:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:00 INFO - 'MOZ_NO_REMOTE': '1', 22:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:00 INFO - 'NO_EM_RESTART': '1', 22:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:00 INFO - 'PWD': '/builds/slave/test', 22:59:00 INFO - 'SHELL': '/bin/bash', 22:59:00 INFO - 'SHLVL': '1', 22:59:00 INFO - 'TERM': 'linux', 22:59:00 INFO - 'TMOUT': '86400', 22:59:00 INFO - 'USER': 'cltbld', 22:59:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:00 INFO - '_': '/tools/buildbot/bin/python'} 22:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:00 INFO - Downloading/unpacking psutil>=3.1.1 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:02 INFO - Installing collected packages: psutil 22:59:02 INFO - Running setup.py install for psutil 22:59:02 INFO - building 'psutil._psutil_linux' extension 22:59:02 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 22:59: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 22:59:03 INFO - building 'psutil._psutil_posix' extension 22:59: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 22:59: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:59:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:59:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:59:03 INFO - Successfully installed psutil 22:59:03 INFO - Cleaning up... 22:59:03 INFO - Return code: 0 22:59:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:59:03 INFO - Using env: {'DISPLAY': ':0', 22:59:03 INFO - 'HOME': '/home/cltbld', 22:59:03 INFO - 'LANG': 'en_US.UTF-8', 22:59:03 INFO - 'LANGUAGE': 'en_US:en', 22:59:03 INFO - 'LOGNAME': 'cltbld', 22:59:03 INFO - 'MAIL': '/var/mail/cltbld', 22:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:03 INFO - 'MOZ_NO_REMOTE': '1', 22:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:03 INFO - 'NO_EM_RESTART': '1', 22:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:03 INFO - 'PWD': '/builds/slave/test', 22:59:03 INFO - 'SHELL': '/bin/bash', 22:59:03 INFO - 'SHLVL': '1', 22:59:03 INFO - 'TERM': 'linux', 22:59:03 INFO - 'TMOUT': '86400', 22:59:03 INFO - 'USER': 'cltbld', 22:59:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:03 INFO - '_': '/tools/buildbot/bin/python'} 22:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:59:05 INFO - Installing collected packages: mozsystemmonitor 22:59:05 INFO - Running setup.py install for mozsystemmonitor 22:59:05 INFO - Successfully installed mozsystemmonitor 22:59:05 INFO - Cleaning up... 22:59:05 INFO - Return code: 0 22:59:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:05 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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:05 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 22:59:05 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 22:59:05 INFO - Using env: {'DISPLAY': ':0', 22:59:05 INFO - 'HOME': '/home/cltbld', 22:59:05 INFO - 'LANG': 'en_US.UTF-8', 22:59:05 INFO - 'LANGUAGE': 'en_US:en', 22:59:05 INFO - 'LOGNAME': 'cltbld', 22:59:05 INFO - 'MAIL': '/var/mail/cltbld', 22:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:05 INFO - 'MOZ_NO_REMOTE': '1', 22:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:05 INFO - 'NO_EM_RESTART': '1', 22:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:05 INFO - 'PWD': '/builds/slave/test', 22:59:05 INFO - 'SHELL': '/bin/bash', 22:59:05 INFO - 'SHLVL': '1', 22:59:05 INFO - 'TERM': 'linux', 22:59:05 INFO - 'TMOUT': '86400', 22:59:05 INFO - 'USER': 'cltbld', 22:59:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:05 INFO - '_': '/tools/buildbot/bin/python'} 22:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:05 INFO - Downloading/unpacking jsonschema==2.5.1 22:59:05 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 22:59:05 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 22:59:05 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 22:59:05 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 22:59:05 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 22:59:05 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 22:59:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:59:07 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 22:59:07 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 22:59:07 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 22:59:07 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 22:59:07 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 22:59:07 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 22:59:08 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:08 INFO - warning: no files found matching '*.txt' 22:59:08 INFO - no previously-included directories found matching 'build' 22:59:08 INFO - no previously-included directories found matching 'dist' 22:59:08 INFO - no previously-included directories found matching '.git*' 22:59:08 INFO - Installing collected packages: jsonschema, functools32 22:59:08 INFO - Running setup.py install for functools32 22:59:08 INFO - warning: no files found matching '*.txt' 22:59:08 INFO - no previously-included directories found matching 'build' 22:59:08 INFO - no previously-included directories found matching 'dist' 22:59:08 INFO - no previously-included directories found matching '.git*' 22:59:08 INFO - Successfully installed jsonschema functools32 22:59:08 INFO - Cleaning up... 22:59:08 INFO - Return code: 0 22:59:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:59:08 INFO - Using env: {'DISPLAY': ':0', 22:59:08 INFO - 'HOME': '/home/cltbld', 22:59:08 INFO - 'LANG': 'en_US.UTF-8', 22:59:08 INFO - 'LANGUAGE': 'en_US:en', 22:59:08 INFO - 'LOGNAME': 'cltbld', 22:59:08 INFO - 'MAIL': '/var/mail/cltbld', 22:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:08 INFO - 'MOZ_NO_REMOTE': '1', 22:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:08 INFO - 'NO_EM_RESTART': '1', 22:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:08 INFO - 'PWD': '/builds/slave/test', 22:59:08 INFO - 'SHELL': '/bin/bash', 22:59:08 INFO - 'SHLVL': '1', 22:59:08 INFO - 'TERM': 'linux', 22:59:08 INFO - 'TMOUT': '86400', 22:59:08 INFO - 'USER': 'cltbld', 22:59:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:08 INFO - '_': '/tools/buildbot/bin/python'} 22:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:08 INFO - Downloading/unpacking blobuploader==1.2.4 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:10 INFO - Downloading blobuploader-1.2.4.tar.gz 22:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:59:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:59:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:10 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 22:59:11 INFO - Downloading docopt-0.6.1.tar.gz 22:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:59:11 INFO - Installing collected packages: blobuploader, requests, docopt 22:59:11 INFO - Running setup.py install for blobuploader 22:59:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:59:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:59:11 INFO - Running setup.py install for requests 22:59:11 INFO - Running setup.py install for docopt 22:59:11 INFO - Successfully installed blobuploader requests docopt 22:59:11 INFO - Cleaning up... 22:59:11 INFO - Return code: 0 22:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:11 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')]} 22:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 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')]} 22:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:11 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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:11 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 22:59:11 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 22:59:11 INFO - Using env: {'DISPLAY': ':0', 22:59:11 INFO - 'HOME': '/home/cltbld', 22:59:11 INFO - 'LANG': 'en_US.UTF-8', 22:59:11 INFO - 'LANGUAGE': 'en_US:en', 22:59:11 INFO - 'LOGNAME': 'cltbld', 22:59:11 INFO - 'MAIL': '/var/mail/cltbld', 22:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:11 INFO - 'MOZ_NO_REMOTE': '1', 22:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:11 INFO - 'NO_EM_RESTART': '1', 22:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:11 INFO - 'PWD': '/builds/slave/test', 22:59:11 INFO - 'SHELL': '/bin/bash', 22:59:11 INFO - 'SHLVL': '1', 22:59:11 INFO - 'TERM': 'linux', 22:59:11 INFO - 'TMOUT': '86400', 22:59:11 INFO - 'USER': 'cltbld', 22:59:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:11 INFO - '_': '/tools/buildbot/bin/python'} 22:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:11 INFO - Running setup.py (path:/tmp/pip-_LB5AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:12 INFO - Running setup.py (path:/tmp/pip-HkfkFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:12 INFO - Running setup.py (path:/tmp/pip-6ZIhiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:12 INFO - Running setup.py (path:/tmp/pip-TSOcNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:12 INFO - Running setup.py (path:/tmp/pip-OzgX2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:12 INFO - Running setup.py (path:/tmp/pip-34d6eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:12 INFO - Running setup.py (path:/tmp/pip-ksuf9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:12 INFO - Running setup.py (path:/tmp/pip-FLyGRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:12 INFO - Running setup.py (path:/tmp/pip-zOPVBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:12 INFO - Running setup.py (path:/tmp/pip-tDP91b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:12 INFO - Running setup.py (path:/tmp/pip-33Ye4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:12 INFO - Running setup.py (path:/tmp/pip-fEsYDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:12 INFO - Running setup.py (path:/tmp/pip-L79CxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:12 INFO - Running setup.py (path:/tmp/pip-PdXbcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:12 INFO - Running setup.py (path:/tmp/pip-9UBpCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:13 INFO - Running setup.py (path:/tmp/pip-wFxXMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:13 INFO - Running setup.py (path:/tmp/pip-XMA2lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:59:13 INFO - Running setup.py install for manifestparser 22:59:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozcrash 22:59:13 INFO - Running setup.py install for mozdebug 22:59:13 INFO - Running setup.py install for mozdevice 22:59:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozfile 22:59:13 INFO - Running setup.py install for mozhttpd 22:59:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozinfo 22:59:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Running setup.py install for mozInstall 22:59:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:59:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozleak 22:59:14 INFO - Running setup.py install for mozlog 22:59:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for moznetwork 22:59:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozprocess 22:59:14 INFO - Running setup.py install for mozprofile 22:59:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozrunner 22:59:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Running setup.py install for mozscreenshot 22:59:14 INFO - Running setup.py install for moztest 22:59:14 INFO - Running setup.py install for mozversion 22:59:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:59:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:59:14 INFO - Cleaning up... 22:59:14 INFO - Return code: 0 22:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59: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 22:59: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 22:59:15 INFO - Using env: {'DISPLAY': ':0', 22:59:15 INFO - 'HOME': '/home/cltbld', 22:59:15 INFO - 'LANG': 'en_US.UTF-8', 22:59:15 INFO - 'LANGUAGE': 'en_US:en', 22:59:15 INFO - 'LOGNAME': 'cltbld', 22:59:15 INFO - 'MAIL': '/var/mail/cltbld', 22:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:15 INFO - 'MOZ_NO_REMOTE': '1', 22:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:15 INFO - 'NO_EM_RESTART': '1', 22:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:15 INFO - 'PWD': '/builds/slave/test', 22:59:15 INFO - 'SHELL': '/bin/bash', 22:59:15 INFO - 'SHLVL': '1', 22:59:15 INFO - 'TERM': 'linux', 22:59:15 INFO - 'TMOUT': '86400', 22:59:15 INFO - 'USER': 'cltbld', 22:59:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:15 INFO - '_': '/tools/buildbot/bin/python'} 22:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:59:15 INFO - Running setup.py (path:/tmp/pip-KawdrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:59:15 INFO - Running setup.py (path:/tmp/pip-6UAy34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:59:15 INFO - Running setup.py (path:/tmp/pip-PGJeoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:59:15 INFO - Running setup.py (path:/tmp/pip-5rYkMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:59:15 INFO - Running setup.py (path:/tmp/pip-aC0QLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:59:15 INFO - Running setup.py (path:/tmp/pip-GEdO5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:59:15 INFO - Running setup.py (path:/tmp/pip-dJdpPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:59:15 INFO - Running setup.py (path:/tmp/pip-swXYcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:59:15 INFO - Running setup.py (path:/tmp/pip-v60N_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:59:15 INFO - Running setup.py (path:/tmp/pip-7hinDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:59:15 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)) 22:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:59:15 INFO - Running setup.py (path:/tmp/pip-D8LElr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:59: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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:59:16 INFO - Running setup.py (path:/tmp/pip-Wsw4TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:59: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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:59:16 INFO - Running setup.py (path:/tmp/pip-jklP5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:59:16 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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:59:16 INFO - Running setup.py (path:/tmp/pip-3e57fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:59:16 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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:16 INFO - Running setup.py (path:/tmp/pip-EH9glC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:59:16 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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:59:16 INFO - Running setup.py (path:/tmp/pip-dQLjmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:59:16 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)) 22:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:59:16 INFO - Running setup.py (path:/tmp/pip-bTdEn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:59:16 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)) 22:59:16 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)) 22:59:16 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)) 22:59:16 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)) 22:59:16 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)) 22:59:16 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)) 22:59:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:59:16 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 22:59:16 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 22:59:16 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 22:59:16 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 22:59:16 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 22:59:16 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 22:59:18 INFO - Downloading blessings-1.6.tar.gz 22:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:59:18 INFO - Installing collected packages: blessings 22:59:18 INFO - Running setup.py install for blessings 22:59:18 INFO - Successfully installed blessings 22:59:18 INFO - Cleaning up... 22:59:18 INFO - Return code: 0 22:59:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:18 INFO - Reading from file tmpfile_stdout 22:59:18 INFO - Current package versions: 22:59:18 INFO - argparse == 1.2.1 22:59:18 INFO - blessings == 1.6 22:59:18 INFO - blobuploader == 1.2.4 22:59:18 INFO - docopt == 0.6.1 22:59:18 INFO - functools32 == 3.2.3-2 22:59:18 INFO - jsonschema == 2.5.1 22:59:18 INFO - manifestparser == 1.1 22:59:18 INFO - mozInstall == 1.12 22:59:18 INFO - mozcrash == 0.17 22:59:18 INFO - mozdebug == 0.1 22:59:18 INFO - mozdevice == 0.48 22:59:18 INFO - mozfile == 1.2 22:59:18 INFO - mozhttpd == 0.7 22:59:18 INFO - mozinfo == 0.9 22:59:18 INFO - mozleak == 0.1 22:59:18 INFO - mozlog == 3.2 22:59:18 INFO - moznetwork == 0.27 22:59:18 INFO - mozprocess == 0.22 22:59:18 INFO - mozprofile == 0.28 22:59:18 INFO - mozrunner == 6.11 22:59:18 INFO - mozscreenshot == 0.1 22:59:18 INFO - mozsystemmonitor == 0.3 22:59:18 INFO - moztest == 0.7 22:59:18 INFO - mozversion == 1.4 22:59:18 INFO - psutil == 3.1.1 22:59:18 INFO - requests == 1.2.3 22:59:18 INFO - wsgiref == 0.1.2 22:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:59:18 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')]} 22:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 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')]} 22:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59:18 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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59:18 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 22:59:18 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 22:59:18 INFO - Using env: {'DISPLAY': ':0', 22:59:18 INFO - 'HOME': '/home/cltbld', 22:59:18 INFO - 'LANG': 'en_US.UTF-8', 22:59:18 INFO - 'LANGUAGE': 'en_US:en', 22:59:18 INFO - 'LOGNAME': 'cltbld', 22:59:18 INFO - 'MAIL': '/var/mail/cltbld', 22:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:18 INFO - 'MOZ_NO_REMOTE': '1', 22:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:18 INFO - 'NO_EM_RESTART': '1', 22:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:18 INFO - 'PWD': '/builds/slave/test', 22:59:18 INFO - 'SHELL': '/bin/bash', 22:59:18 INFO - 'SHLVL': '1', 22:59:18 INFO - 'TERM': 'linux', 22:59:18 INFO - 'TMOUT': '86400', 22:59:18 INFO - 'USER': 'cltbld', 22:59:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:18 INFO - '_': '/tools/buildbot/bin/python'} 22:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59: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)) 22:59:19 INFO - Cleaning up... 22:59:19 INFO - Return code: 0 22:59:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59: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 22:59: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 22:59:19 INFO - Using env: {'DISPLAY': ':0', 22:59:19 INFO - 'HOME': '/home/cltbld', 22:59:19 INFO - 'LANG': 'en_US.UTF-8', 22:59:19 INFO - 'LANGUAGE': 'en_US:en', 22:59:19 INFO - 'LOGNAME': 'cltbld', 22:59:19 INFO - 'MAIL': '/var/mail/cltbld', 22:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:19 INFO - 'MOZ_NO_REMOTE': '1', 22:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:19 INFO - 'NO_EM_RESTART': '1', 22:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:19 INFO - 'PWD': '/builds/slave/test', 22:59:19 INFO - 'SHELL': '/bin/bash', 22:59:19 INFO - 'SHLVL': '1', 22:59:19 INFO - 'TERM': 'linux', 22:59:19 INFO - 'TMOUT': '86400', 22:59:19 INFO - 'USER': 'cltbld', 22:59:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:19 INFO - '_': '/tools/buildbot/bin/python'} 22:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:59:19 INFO - Cleaning up... 22:59:19 INFO - Return code: 0 22:59:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:59: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')]} 22:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbdd865f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', '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 22:59: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', 'flake8'] in /builds/slave/test/build 22:59: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 flake8 22:59:19 INFO - Using env: {'DISPLAY': ':0', 22:59:19 INFO - 'HOME': '/home/cltbld', 22:59:19 INFO - 'LANG': 'en_US.UTF-8', 22:59:19 INFO - 'LANGUAGE': 'en_US:en', 22:59:19 INFO - 'LOGNAME': 'cltbld', 22:59:19 INFO - 'MAIL': '/var/mail/cltbld', 22:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:19 INFO - 'MOZ_NO_REMOTE': '1', 22:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:19 INFO - 'NO_EM_RESTART': '1', 22:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:19 INFO - 'PWD': '/builds/slave/test', 22:59:19 INFO - 'SHELL': '/bin/bash', 22:59:19 INFO - 'SHLVL': '1', 22:59:19 INFO - 'TERM': 'linux', 22:59:19 INFO - 'TMOUT': '86400', 22:59:19 INFO - 'USER': 'cltbld', 22:59:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:19 INFO - '_': '/tools/buildbot/bin/python'} 22:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:19 INFO - Downloading/unpacking flake8 22:59:19 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 22:59:19 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 22:59:19 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 22:59:19 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 22:59:19 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 22:59:19 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 22:59:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:59:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 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 22:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:22 INFO - no previously-included directories found matching 'docs/_build' 22:59:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:59:22 INFO - Running setup.py install for pep8 22:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:22 INFO - no previously-included directories found matching 'docs/_build' 22:59:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:59:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:59:22 INFO - Cleaning up... 22:59:22 INFO - Return code: 0 22:59:22 INFO - Running post-action listener: _resource_record_post_action 22:59:22 INFO - Running post-action listener: _start_resource_monitoring 22:59:22 INFO - Starting resource monitoring. 22:59:22 INFO - ##### 22:59:22 INFO - ##### Finished create-virtualenv step (success) 22:59:22 INFO - ##### 22:59:22 INFO - ##### 22:59:22 INFO - ##### Running install step. 22:59:22 INFO - ##### 22:59:22 INFO - Running pre-action listener: _resource_record_pre_action 22:59:22 INFO - Running main action method: install 22:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:59:22 INFO - Reading from file tmpfile_stdout 22:59:22 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:59:22 INFO - Reading from file tmpfile_stdout 22:59:22 INFO - Output received: 22:59:22 INFO - Usage: mozinstall [options] installer 22:59:22 INFO - Options: 22:59:22 INFO - -h, --help show this help message and exit 22:59:22 INFO - -d DEST, --destination=DEST 22:59:22 INFO - Directory to install application into. [default: 22:59:22 INFO - "/builds/slave/test"] 22:59:22 INFO - --app=APP Application being installed. [default: firefox] 22:59:22 INFO - mkdir: /builds/slave/test/build/application 22:59:22 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'] 22:59:22 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 22:59:39 INFO - Reading from file tmpfile_stdout 22:59:39 INFO - Output received: 22:59:39 INFO - /builds/slave/test/build/application/firefox/firefox 22:59:39 INFO - Running post-action listener: _resource_record_post_action 22:59:39 INFO - ##### 22:59:39 INFO - ##### Finished install step (success) 22:59:39 INFO - ##### 22:59:39 INFO - ##### 22:59:39 INFO - ##### Running run-tests step. 22:59:39 INFO - ##### 22:59:39 INFO - Running pre-action listener: _resource_record_pre_action 22:59:39 INFO - Running main action method: run_tests 22:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:59:39 INFO - Python 2.7.3 22:59:39 INFO - Return code: 0 22:59:39 INFO - grabbing minidump binary from tooltool 22:59: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')]} 22:59: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 0x16801c0>, '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 0x16810c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1681550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:59: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 22:59: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 22:59: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 22:59:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:39 INFO - Return code: 0 22:59:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:59:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:59:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:59:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:59:40 INFO - Return code: 0 22:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 22:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 22:59:40 INFO - Using env: {'DISPLAY': ':0', 22:59:40 INFO - 'HOME': '/home/cltbld', 22:59:40 INFO - 'LANG': 'en_US.UTF-8', 22:59:40 INFO - 'LANGUAGE': 'en_US:en', 22:59:40 INFO - 'LOGNAME': 'cltbld', 22:59:40 INFO - 'MAIL': '/var/mail/cltbld', 22:59:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:59:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:40 INFO - 'MOZ_NO_REMOTE': '1', 22:59:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:40 INFO - 'NO_EM_RESTART': '1', 22:59:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:59:40 INFO - 'PWD': '/builds/slave/test', 22:59:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:59:40 INFO - 'SHELL': '/bin/bash', 22:59:40 INFO - 'SHLVL': '1', 22:59:40 INFO - 'TERM': 'linux', 22:59:40 INFO - 'TMOUT': '86400', 22:59:40 INFO - 'USER': 'cltbld', 22:59:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212', 22:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:40 INFO - '_': '/tools/buildbot/bin/python'} 22:59:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 22:59:40 INFO - mozversion application_buildid: 20160607203013 22:59:40 INFO - mozversion application_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 22:59:40 INFO - mozversion application_display_name: Nightly 22:59:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:40 INFO - mozversion application_name: Firefox 22:59:40 INFO - mozversion application_remotingname: firefox 22:59:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:59:40 INFO - mozversion application_vendor: Mozilla 22:59:40 INFO - mozversion application_version: 50.0a1 22:59:40 INFO - mozversion platform_buildid: 20160607203013 22:59:40 INFO - mozversion platform_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 22:59:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:59:40 INFO - mozversion platform_version: 50.0a1 22:59:40 INFO - using testdate: 1465365580 22:59:40 INFO - actual date: 1465365580 22:59:40 INFO - starting webserver on 'localhost:38346' 22:59:40 INFO - SUITE-START | Running 2 tests 22:59:40 INFO - TEST-START | dromaeo_css 22:59:40 INFO - operating with platform_type : linux_ 22:59:40 INFO - Initialising browser for dromaeo_css test... 22:59:40 INFO - TEST-INFO | started process 23979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQBLsN/profile http://localhost:38346/getInfo.html) 22:59:46 INFO - PROCESS | 23979 | __metrics Screen width/height:1600/1200 22:59:46 INFO - PROCESS | 23979 | colorDepth:24 22:59:46 INFO - PROCESS | 23979 | Browser inner width/height: 1024/697 22:59:46 INFO - PROCESS | 23979 | __metrics 22:59:47 ERROR - PROCESS | 23979 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 22:59:48 INFO - TEST-INFO | 23979: exit 0 22:59:48 INFO - Browser initialized. 22:59:48 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:48 INFO - TEST-INFO | started process 24097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxQBLsN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:00:00 INFO - PROCESS | 24097 | RSS: Main: 167370752 23:00:00 INFO - PROCESS | 24097 | 23:00:50 INFO - PROCESS | 24097 | 1465365650098 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] 23:02:57 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38346/tests/dromaeo/cssquery-ext.html) 23:02:58 INFO - PROCESS | 24097 | RSS: Main: 170258432 23:02:58 INFO - PROCESS | 24097 | 23:06:00 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-ext.html (next: http://localhost:38346/tests/dromaeo/cssquery-jquery.html) 23:06:01 INFO - PROCESS | 24097 | RSS: Main: 169771008 23:06:01 INFO - PROCESS | 24097 | 23:09:03 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38346/tests/dromaeo/cssquery-mootools.html) 23:09:03 INFO - PROCESS | 24097 | RSS: Main: 171638784 23:09:03 INFO - PROCESS | 24097 | 23:12:05 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38346/tests/dromaeo/cssquery-prototype.html) 23:12:06 INFO - PROCESS | 24097 | RSS: Main: 168280064 23:12:06 INFO - PROCESS | 24097 | 23:15:08 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38346/tests/dromaeo/cssquery-yui.html) 23:15:09 INFO - PROCESS | 24097 | RSS: Main: 170160128 23:15:09 INFO - PROCESS | 24097 | 23:18:11 INFO - PROCESS | 24097 | Cycle 1(1): loaded http://localhost:38346/tests/dromaeo/cssquery-yui.html (next: http://localhost:38346/tests/dromaeo/cssquery-dojo.html) 23:18:12 INFO - PROCESS | 24097 | RSS: Main: 171843584 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | __start_tp_report 23:18:12 INFO - PROCESS | 24097 | _x_x_mozilla_page_load 23:18:12 INFO - PROCESS | 24097 | _x_x_mozilla_page_load_details 23:18:12 INFO - PROCESS | 24097 | |i|pagename|runs| 23:18:12 INFO - PROCESS | 24097 | |0;dojo.html;3132.7807053506253;3187.2191313128287;3200.5839240898695;3222.822744749038;3234.7250483708885;5416.404195538487;5428.430014848438;5441.428649991753;5453.154761012044;5473.261109750182;5358.223057656637;5422.6475279106835;5438.075527160382;5458.890822183554;5490.945090549093;4879.438864530571;4909.803607855682;5016.27264046713;5063.898722025558;5091.261767043777;812.1973637152594;4931.802727890898;5024.698518088908;5052.469490703478;5053.1157047516535;4955.231939049453;4977.203647416414;4978.850634480971;4991.251312303148;5038.39539255288;4831.782569784333;5003.099442100421;5016.623753218523;5029.899402011939;5080.542751152414;4869.805207791684;4932.235503496964;4932.556069953722;4937.580305674022;4950.183219768734;5317.73411329432;5385.515303622654;5404.405515393303;5425.02349577076;5426.375966763794;5715.114157305583;5758.539316854642;5882.794102206445;5893.381194974551;5895.675737834417;5754.647657800414;5761.135829625548;5773.422657734235;5783.5951483396175;5794.478496935254;5400;5407.810726624589;5415.268938693265;5423.267858839045;5433.1035379162395;5800.796972105956;5856.677882716492;5871.823845284648;5893.882122357529;5903.704814759245;5700.287464066992;5764.452377024176;5775.537956963432;5785.971070144622;5825.1844741736195;5843.707814609337;5859.648421094748;5860.736266868002;5861.120831875252;5866.501347385435;5684.9431505684415;5770.6249093808765;5848.093545500455;5851.210086638334;5870.677112758839;5720.914186287209;5836.270466191726;5867.325257595431;5907.556933229939;5982.222311099529;4458.041521072985;4496.437945256843;4507.233770258998;4507.571780680895;4553.977230113828;3906.4140378942816;3943.2902077626304;3973.4635824163947;4003.939940900889;4058.736182148151;5640.069388550925;5642.322921249394;5644.379118296984;5646.830595082154;5694.886102277931;5866.6186697864505;5963.224780778471;5965.343812180657;5972.731227094791;5988.401159883977;5359.866003349947;5583.246261754693;5597.384287728347;5638.464345887216;5638.830835074954;5077.847664570068;5082.313887625197;5091.618128640367;5098.056859481007;5109.56568691658;6058.091286307089;6076.939230607726;6094.268687757498;6099.268087829489;6117.510599152057;5709.486146246774;5869.882602347929;5890.528757699288;5922.585419020799;5964.165016897725;6073.362296958756;6081.756729730761;6088.086786981989;6100.176476175659;6113.113598528277;5564.443555644403;5804.593678442468;5845.883082338414;5853.678047707247;5866.7066646668345;5821.79623713168;5864.354920958776;5883.176355310175;5895.882082358415;5899.823005309676;5685.857853553529;5709.172170035238;5757.453041961007;5767.134929760569;5772.336181339199;5572.498475137257;5617.269754931833;5679.290088738908;5739.540836733135;5746.9712651436475;5428.4842939920645;5512.283403157564;5593.133064375028;5598.972005139948;5667.659940403589;5770.076787713946;5817.709114544171;5833.358330583717;5843.678597677169;5844.094165404369;5434.75543600531;5549.805756798492;5695.7436915338085;5701.543876489788;5708.714564271853 23:18:12 INFO - PROCESS | 24097 | |1;ext.html;578.178985840107;637.7321524959517;640.8590110175762;647.9481641468682;648.0473703655628;33656;36273.63726362739;44102.999999999956;45323;45503.54496455035;45395.31907021398;46208.30687539681;46228;46323;46347.84130396742;8545.572721363938;8625.439346442461;8660.133986601353;8696.304295656364;8705.173008564176;8791.912080879174;8900.910990890074;8932.732018039436;8935.508547029944;8967.103289671013;8935.687250946217;8959.865602015941;8969.865452018224;8976.147266009719;9015.413998090136;8866.379353445262;8982.640694372218;8990.415622984485;8992.820143597091;9027.368084234138;8802.471851688855;8945.955270223672;8948.418352807112;8951.328650351184;8975.237104846095;40312.79843600763;40433.797831010954;40581.59418405808;40632.39051414231;40683;3503.4744788281705;3545.840437180307;3570.5179800727087;3602.343621224459;3629.709623230135;29927.551086733718;32414;32417.837910810296;32423.837880810446;32429.51355729666;4395.252807022814;4475.1944649963;4503.497620021752;4546.227141385973;4631.791569379352;349233;352063.63649999496;353624;355230;356729;35010.82494587562;62578;62947.37052629507;63031.68484157642;63048.36951630425;37159.25681486409;37358.43962340567;37503.249935001695;37525.437118443246;37643.43534846979;14898.404063837324;15094.094354338555;15115.773263401057;15122.243887805786;15162.924185379003;13253.933730331286;13484.325783710776;13495.325233738471;13539.323033848268;13548.051636385555;8438.113998030118;8504.659813607386;8506.276966457921;8540.487570745776;8585.441946273597;3234.7573931954726;3259.282957749291;3288.9506657400157;3294.736421086355;3302.3725492156414;1008.626808081;1044.2794471814423;1049.5906596427399;1096.4024606589428;1150.206357613244;33488.8278910237;33589.66410335866;33636.49545256823;33831.32337353288;33848.66151338504;1131.1007748839693;1141.9371934543515;1154.1978325064;1169.1231576317762;1228.7235372041398;16952.321907123824;17598.863884640552;17659.55851103707;17677.7348339775;17678.11609419524;615956;624707;625255;626213.4757304828;628399;60368.39631603716;60570.69714651399;61140.38859611436;61184.38815611876;61191.69404152951;1290.2065229883553;1374.3815283122635;1389.0485017762865;1389.2567476400077;1389.5275606293908;30491.39017219599;32836.179095522806;33222.52863282919;33297;33336.33327333488;52288.21567676412;52604.736976314874;52851.207231892324;52927.73536132295;53224;482848;483507;485016;487718;489728;28370.71629283681;28530.144095677162;28569.28576785597;28753.281167970967;28946.276343090747;48783.75608121937;49023.26465103098;49811.25283120829;49865.25202122044;50145;40858;41720.79139604283;41937;42060.36909446299;42075.7896210517;40929.38605920854;41412.171756564094;41793.37309940414;41834.37248441337;41885.37171942362;40945.59054409537;41506;41554.36450970394;41630;41923;35241.29517409586;36848;37052.81473592615;37418.812905936386;37726;28699;28914.132576022752;28936.421271574873;28949.855250723613;29166.708332916398 23:18:12 INFO - PROCESS | 24097 | |2;jquery.html;381.30602303807063;381.452615496762;384.3351002765216;399.96600288975435;400.1097557933596;16924.661506769873;18808.43574692758;18946.147423365946;19032.61934761304;19163.808361916377;10942.343459392441;11703;18783.62432751344;19128.61742765144;19186.520336991583;5038.6724862883975;5164.974175129119;5202.297689811865;5215.6349055566125;5223.190405487156;3863.652271295583;5560.999020176367;5813.767449302023;5832.037713777222;5930.822075337725;5618.297712785902;5742.196092547026;5811.476967072963;5836.095405212178;5844.035734103868;5806.854828629276;5856.209411729405;5881.088431293157;5900.67546284952;5905.940940590582;5532.391436941974;5673.716314184274;5704.286964129484;5718.5425165987035;5724.141378793172;13464.730705385935;13478.730425391535;13522.12106213093;13593.728125437534;21671;2064.370367038053;2171.9239826605994;2214.5460180662926;2228.387193521778;2376.5484557933937;9364.484953327565;9480.857787133198;9559;9815.41107533543;9850.408975461496;1800.2349001674236;1846.4645252876649;1875.3998720409475;1913.9521511962173;1936.893470859102;65262.67368663174;82383.58808205981;82569.58715206446;85158;86764.13235867623;10172.542235599416;10344;10404.479776011169;10429.895701042893;10551.788964220672;14301.64245893861;14307.78538321926;14729.189894555688;14734.63163420923;14908.776368354484;7622.733204337933;8000.759977200693;8013.358931285483;8124.471909325875;8140.918590814016;7791.922080779233;7827;7851.882221766678;7951.244631759973;7964.920350796418;4304.956950430518;4371.825126994884;4422.535633758409;4428.092241090633;4570;1515.726789496828;1636.443609172863;1641.6880792649358;1648.826873178323;1650.521348808856;927.2720914082413;966.970990870275;1039.875214974208;1070.9558180773683;1139.641013080877;18250.81749182518;18518.259269629332;18839.340623078126;19093.331733389266;19278.614427711367;1000.5847573257163;1003.814294355532;1016.1159790981893;1019.3119644240109;1067.0396643021343;10192.694219173436;10636.202284828514;10746.94626526878;10765.946170269099;10781.892181078245;488045;489619;490010;501430;502175;87972.12027879768;94062.5296873525;98215.50892245636;100456;102040.44898877587;1008.6671398438498;1028.2956175020136;1056.1920131099714;1059.4914441068177;1073.88187299397;17355.47933561995;17383.739243911605;17754.91122544379;17761.11194440247;17771;40280.3957940637;41645.79177104216;42059.15881682288;42300.36549451699;42764.358534622625;58298.12552811796;59085.40914590971;60214.83877095007;60810.39189608224;61402.692986534785;8362.498250105013;8386.580670966548;8490.23587877094;8596.054434012378;8832.160944710242;9429.57566909477;11668.416579171177;12229.75540489203;13205.669858253621;13369.53206637763;10840.891591083988;11252.324860508395;11309.830352544883;11414;11623.883761162619;10553.314034587727;11134.498947547218;11305.943470282597;11442.94278528602;11657.358845263592;11121.944390277997;11790.823137653113;11980.520779168735;12081.879181208076;12226.327551984727;8483.406161568631;8620.396572240134;8661;8962.14859588338;8962.596683149144;11439.942800285946;12087.335196563921;12096;12124.636260912186;12156.635300940987 23:18:12 INFO - PROCESS | 24097 | |3;mootools.html;1513.0467805282672;1513.6291608555905;1667.808202056763;1795.1114198471757;1806.1420825108066;7331.376832969191;8031.718889838857;8340.666373345059;8585.098564650707;8585.184407481287;8307.626156822942;8485.236328730412;8555.358348123884;8575.78560535987;8599.828003439943;2298.8965496552696;2326.4765427778784;2346.6010778167665;2358.7995020423286;2364;2274.0789980058103;2310.6649535817296;2337.1118974789556;2344.5896968030524;2363.1492662641435;2304.7349554801244;2310.8844557772127;2327.0575416956076;2350.0364850411333;2355.3875992242056;2225.2100504320897;2242.4842286274247;2244.236959433792;2244.7194100737406;2250.7524172340945;2199.9340019799433;2208.4699672078746;2215.9778402215934;2230.988845055764;2234.296196698051;8518.957405212934;8646.783830404227;8657.696980605648;8681.652733890636;8691.608877600524;5110.770015349318;5219.5041471060185;5231.555317797992;5236.869078273074;5243.632945693803;3212.4538828399227;3258.7881787683964;3400.863965441379;3423.845926933294;3428.6914177723875;1151.890570395811;1184.09416796151;2092.696558998952;2134.594427058854;2155.8167555757777;11853.46659400329;11908.821367679491;11953.983911367544;12026.579069732517;12085.27488350693;4366.476022877211;4465.441819772528;4503.684742068024;4529.13946350199;4536.954630453653;9498.19265362452;9541.284403669753;9552.95223523878;9556.617735290649;9564.426134431957;5070.2141168119;5154.355705536808;5158.484151584811;5162.793488260502;5182.844514664566;4099.815508302134;4640.791164397543;4769.594584460359;4771.665983381199;4775.5224477551965;3778.848846046127;3784.262068896594;3859.5754467008605;3860.3823388257742;3886.436466712311;1146.7419830538063;1153.6827372472637;1159.5072094359864;1161.4018780328138;1165.5279611757082;868.843608150539;1014.5282443663732;1026.8511065895402;1031.8555402243692;1088.357868857362;6093.725782339805;6103.450689437972;6221;6265.310815810257;6364.7135878885565;451.95028546859817;459.10932790386545;463.10158292911643;463.4137815663189;467.29438547793075;3760.7367484276383;3846.9615303847163;3859.150986782903;3877.3020856245585;3941.6452519273403;10187.490625468698;10450.947745261225;10480.161587073168;10542.525586348633;10582.153427725763;10580.52387642558;10615.52230149645;10652.62715804943;10706.518206680717;10757.30077544957;7775.844483110306;7876.645550950221;7974;7986.880196797053;8031.638576264082;6062.090686397076;6282.560220784501;6315.431611155018;6385.840353991188;6399.8080057598345;9669.661561845302;9688.176504997155;9852.261080418853;9868.358556693793;10023.498825058572;10076.647317343857;10155.086042255936;10197.23520735933;10220.488975551341;10224.846627300447;6925.480588955949;7318.377937875341;7435.219301973431;7772.92227077722;7943.285104340637;8191.344692424711;8273.83452330962;8298.045724741733;8326.958365208135;8363.540005299523;6952.826179345557;7149.785506434815;7162.89255661155;7211.567305961449;7428.442866784904;6918.584884906922;6950.930490695028;7040.155181378267;7159;7180.712771489082;6749.055132281583;6782.152230971129;6810.114685090906;6817.181938167451;6819.659017049227;5004.099262132851;5045.495450455072;5144.434112247575;5310;5333.386660534088;5156.381234251914;5289.68261904287;5305.230741542532;5323.1216849219445;5382.381026182039 23:18:12 INFO - PROCESS | 24097 | |4;prototype.html;320.77866272272115;326.15037826462066;326.74350634751727;329.6456309467322;334.28629875216404;5453.481919217678;5537.197106419567;5601.29983752031;5618.4943355098085;5678.801241956532;5616.101423772197;5632.690202038896;5650.463205995434;5658.264425624663;5660.377358490573;4322;4324.156789426047;4333.739975601474;4348.304161377066;4389.363542286366;4112.97943510282;4302.741835489881;4330.631896288819;4400.471943366801;4429;4261.382099595557;4268.658507319407;4284.335927931175;4301.419308393374;4327.199468098396;4323.3947247385395;4324.718893271927;4330.805113769888;4334.219840428722;4356.259435895905;3591.892243232707;3784.9432258516144;3794.696424286078;3803.7527560708463;3808.7905165215902;5408.945910540923;5418.295621569171;5421.539169170625;5450.29146210994;5462.644928079662;4918.96701692645;4943.258511223309;4945.184044632631;4949.7772600233075;4983.825566105169;5494.862628434281;5856.853578660525;5864.179014937912;5886.20536227608;5897.292324920994;4109.589041095896;4114.444549985774;4115.8971025724595;4126.91746165078;4134.214499245134;6019.4883434908525;6086.300075491286;6126.23422072241;6126.540509461764;6185.381461853824;4123.237201117803;4171.353440216772;4201.781483369849;4212.662986961036;4220.978895105505;4237.87286381409;4244.257254980366;4244.681648876347;4259.382389553497;4260.211860805699;4855.635827312965;4877.707337559757;4887.706737595756;4922.114019476457;4949.48030456804;5839.204950608593;5897.380775018647;5913.438223368859;5941.168236446901;5980.641161530322;1462.676277968419;1473.8747206487353;1475.32135217801;1477.9432705615536;1485.123776971592;878.2622597018535;921.2952091649893;926.8980412154658;939.6335429182624;951.619352259088;4993.151164302005;5030.547250747451;5049.005642771085;5072.873178170502;5078.7460626968505;5326.813561525328;5391.487808658171;5453.127499600045;5467.840203119746;5474.233607294982;5079.74601269935;5096.745162741848;5137.0701413418765;5274.57369609976;5780.768769249267;3223;3234.7897386669792;3255;3268.4280250956463;3274.6561611030497;6140;6228.8788018156265;6280.466160376419;6283.7800676976085;6296.370362963667;6177.84555386119;6183.443490085914;6202.906956395657;6219.595726277777;6222.471089957314;6148.200733904474;6151.569390142647;6247.937520624736;6278.524546731514;6292.937070629327;5857.531397488276;5996.67018313997;6096.622317296346;6097.32929377777;6135.877282454415;6004.099385092271;6033.456988871023;6034.849128771816;6041.848953776191;6046.2139921809885;5920.644761314335;6106.572539922163;6190.41191086846;6211.13044173807;6245.500359971283;4235.30117530604;4240.681948853787;4253.595908388698;4273.059926816096;4299.892502687333;6148.139260503443;6179.3202747698615;6187.226596675416;6187.257529096537;6206.844828879314;5748.6838223898085;5899.849529341737;5982.581219314607;6010.909836352545;6030.7286172121485;5879.323877754113;5883.323417807007;5914.940850591439;5941.940580594139;5971.164037034905;5759.0605264599635;5825.50483208932;5852.092925596539;5897.764089436375;5901.498372638373;5766.365699772938;5916.763329466945;5945.286565612154;5980.401959803985;6002.429769171922;5880.294714532738;5888.793892213752;5908.645481271137;5915.112733089899;5931.436513531207 23:18:12 INFO - PROCESS | 24097 | |5;yui.html;711.7010855440715;750.4334227658119;762.6377470701417;790.9248621380967;793.3890904003913;15352.692946141071;15726.056436613811;15992.200389980513;16007.359705611761;16068;14157.150570965749;14217.644558886033;14251.928740356283;14302.07036542624;14302.57092287233;680.4760334542399;797.2784629909926;797.7766225456882;811.6875003123811;811.9918800812005;789.4631650477672;793.5952664141272;795.2921899509412;797.2227078598349;798.5647821937058;833.3749687734199;837.0583094019229;839.0225387423644;839.5969934431477;843.1652663862762;824.9752507424787;832.3258160889638;833.62903507939;834.390894646905;838.2748922182299;607.6506009044817;610.4902406490586;610.7434877351478;612.5987478201785;613.7268915332679;14333.354999025069;14353.497627583089;14365;14391.064580802215;14421.495247666282;14721;15114.848851511455;15135.924320378437;15270.16014119223;15345.923270383577;11912.523499060027;11984.820227696591;12090.637280881587;12172.087093468026;12606.117571769979;3797.2215695782297;3947.3486874665646;3994.6205110514456;4029.5567487576345;4043.5349934757587;71132.6443367785;72388;74812;74841.62579187124;74857.62571187163;11536.884631153749;11555.075593952464;11647.941760291144;11708.590199342982;11725.941370293265;22145.33563993083;22153.224637137624;22338.888305558692;22376.55246895053;22476.55046899053;7991.041075071029;8085.676572937135;8181.3863960203225;8521.062683104854;8535.402521823537;4394.582514661102;4453.465584129925;4492.842750503717;4497.617702495259;4497.910041799146;3344.8494817733263;3454.7408944329277;3459.7924124552605;3462.428699264593;3471.0454624978333;572.0760971031837;576.0380165124252;577.4456521739094;583.4777873802923;586.6450797267677;641.6887809412431;684.3122661725034;745.6532712288812;758.8102974256436;764.5221736414741;8401.579921004048;8484.15158484159;8609.827803443895;8896.243819275434;9185.63257469707;641.1568787045021;699.6921354603958;705.2806137739477;747.872861613527;780.4479352517237;4355.259605867011;4448.888777780581;4576.26779715244;4670.136024835417;4697.31888876111;68518;69172;69345.65327173332;69662;110075.44962275297;94431;96753.51623241839;97411.51294243483;97682;97708.51145744367;80892;82295.17704822995;82835;82949.17050829415;83269;8784.604692788967;8979.730608081769;8987.955060224918;9008.459492430475;9128.361014729171;50327.245091322926;50757;51869;52813.94372112613;54284.45715542794;64150;66608;67292.66353668396;73998;78577.82133267891;10659.573617055232;10869.945650271698;10887.727806804893;12529.436175372313;12546.749065018832;14588.489402870848;15028.647421732097;15186;15201;16083.276252568428;13882.51411200603;14031.929840350733;14087.436502539784;14248.928755356157;14475.85524144745;13619.387127579084;13636.931815341257;14323.283835807959;14427.567172984827;14484.420623174956;11535.8269625954;13724.65688357759;14101.576952691436;14363.497277595234;14390.424383024561;10816.513256903301;10982.254436390902;11074.833877491683;11180.664580062612;11654.501581211625;11001.61494347694;11254.29681848335;11507.309561426342;11527.596534121265;11528.135389845962 23:18:12 INFO - PROCESS | 24097 | __end_tp_report 23:18:12 INFO - PROCESS | 24097 | __start_cc_report 23:18:12 INFO - PROCESS | 24097 | _x_x_mozilla_cycle_collect,342 23:18:12 INFO - PROCESS | 24097 | __end_cc_report 23:18:12 INFO - PROCESS | 24097 | __startTimestamp1465366692127__endTimestamp 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | ------- Summary: start ------- 23:18:12 INFO - PROCESS | 24097 | Number of tests: 6 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#0] dojo.html Cycles:165 Average:5411.51 Median:5667.66 stddev:711.23 (12.5%) stddev-sans-first:690.58 23:18:12 INFO - PROCESS | 24097 | Values: 3132.8 3187.2 3200.6 3222.8 3234.7 5416.4 5428.4 5441.4 5453.2 5473.3 5358.2 5422.6 5438.1 5458.9 5490.9 4879.4 4909.8 5016.3 5063.9 5091.3 812.2 4931.8 5024.7 5052.5 5053.1 4955.2 4977.2 4978.9 4991.3 5038.4 4831.8 5003.1 5016.6 5029.9 5080.5 4869.8 4932.2 4932.6 4937.6 4950.2 5317.7 5385.5 5404.4 5425.0 5426.4 5715.1 5758.5 5882.8 5893.4 5895.7 5754.6 5761.1 5773.4 5783.6 5794.5 5400.0 5407.8 5415.3 5423.3 5433.1 5800.8 5856.7 5871.8 5893.9 5903.7 5700.3 5764.5 5775.5 5786.0 5825.2 5843.7 5859.6 5860.7 5861.1 5866.5 5684.9 5770.6 5848.1 5851.2 5870.7 5720.9 5836.3 5867.3 5907.6 5982.2 4458.0 4496.4 4507.2 4507.6 4554.0 3906.4 3943.3 3973.5 4003.9 4058.7 5640.1 5642.3 5644.4 5646.8 5694.9 5866.6 5963.2 5965.3 5972.7 5988.4 5359.9 5583.2 5597.4 5638.5 5638.8 5077.8 5082.3 5091.6 5098.1 5109.6 6058.1 6076.9 6094.3 6099.3 6117.5 5709.5 5869.9 5890.5 5922.6 5964.2 6073.4 6081.8 6088.1 6100.2 6113.1 5564.4 5804.6 5845.9 5853.7 5866.7 5821.8 5864.4 5883.2 5895.9 5899.8 5685.9 5709.2 5757.5 5767.1 5772.3 5572.5 5617.3 5679.3 5739.5 5747.0 5428.5 5512.3 5593.1 5599.0 5667.7 5770.1 5817.7 5833.4 5843.7 5844.1 5434.8 5549.8 5695.7 5701.5 5708.7 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#1] ext.html Cycles:180 Average:63357.21 Median:41178.88 stddev:133471.45 (324.1%) stddev-sans-first:133762.65 23:18:12 INFO - PROCESS | 24097 | Values: 578.2 637.7 640.9 647.9 648.0 33656.0 36273.6 44103.0 45323.0 45503.5 45395.3 46208.3 46228.0 46323.0 46347.8 8545.6 8625.4 8660.1 8696.3 8705.2 8791.9 8900.9 8932.7 8935.5 8967.1 8935.7 8959.9 8969.9 8976.1 9015.4 8866.4 8982.6 8990.4 8992.8 9027.4 8802.5 8946.0 8948.4 8951.3 8975.2 40312.8 40433.8 40581.6 40632.4 40683.0 3503.5 3545.8 3570.5 3602.3 3629.7 29927.6 32414.0 32417.8 32423.8 32429.5 4395.3 4475.2 4503.5 4546.2 4631.8 349233.0 352063.6 353624.0 355230.0 356729.0 35010.8 62578.0 62947.4 63031.7 63048.4 37159.3 37358.4 37503.2 37525.4 37643.4 14898.4 15094.1 15115.8 15122.2 15162.9 13253.9 13484.3 13495.3 13539.3 13548.1 8438.1 8504.7 8506.3 8540.5 8585.4 3234.8 3259.3 3289.0 3294.7 3302.4 1008.6 1044.3 1049.6 1096.4 1150.2 33488.8 33589.7 33636.5 33831.3 33848.7 1131.1 1141.9 1154.2 1169.1 1228.7 16952.3 17598.9 17659.6 17677.7 17678.1 615956.0 624707.0 625255.0 626213.5 628399.0 60368.4 60570.7 61140.4 61184.4 61191.7 1290.2 1374.4 1389.0 1389.3 1389.5 30491.4 32836.2 33222.5 33297.0 33336.3 52288.2 52604.7 52851.2 52927.7 53224.0 482848.0 483507.0 485016.0 487718.0 489728.0 28370.7 28530.1 28569.3 28753.3 28946.3 48783.8 49023.3 49811.3 49865.3 50145.0 40858.0 41720.8 41937.0 42060.4 42075.8 40929.4 41412.2 41793.4 41834.4 41885.4 40945.6 41506.0 41554.4 41630.0 41923.0 35241.3 36848.0 37052.8 37418.8 37726.0 28699.0 28914.1 28936.4 28949.9 29166.7 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#2] jquery.html Cycles:180 Average:28811.65 Median:2193.24 stddev:81682.29 (3724.3%) stddev-sans-first:81883.54 23:18:12 INFO - PROCESS | 24097 | Values: 381.3 381.5 384.3 400.0 400.1 16924.7 18808.4 18946.1 19032.6 19163.8 10942.3 11703.0 18783.6 19128.6 19186.5 5038.7 5165.0 5202.3 5215.6 5223.2 3863.7 5561.0 5813.8 5832.0 5930.8 5618.3 5742.2 5811.5 5836.1 5844.0 5806.9 5856.2 5881.1 5900.7 5905.9 5532.4 5673.7 5704.3 5718.5 5724.1 13464.7 13478.7 13522.1 13593.7 21671.0 2064.4 2171.9 2214.5 2228.4 2376.5 9364.5 9480.9 9559.0 9815.4 9850.4 1800.2 1846.5 1875.4 1914.0 1936.9 65262.7 82383.6 82569.6 85158.0 86764.1 10172.5 10344.0 10404.5 10429.9 10551.8 14301.6 14307.8 14729.2 14734.6 14908.8 7622.7 8000.8 8013.4 8124.5 8140.9 7791.9 7827.0 7851.9 7951.2 7964.9 4305.0 4371.8 4422.5 4428.1 4570.0 1515.7 1636.4 1641.7 1648.8 1650.5 927.3 967.0 1039.9 1071.0 1139.6 18250.8 18518.3 18839.3 19093.3 19278.6 1000.6 1003.8 1016.1 1019.3 1067.0 10192.7 10636.2 10746.9 10765.9 10781.9 488045.0 489619.0 490010.0 501430.0 502175.0 87972.1 94062.5 98215.5 100456.0 102040.4 1008.7 1028.3 1056.2 1059.5 1073.9 17355.5 17383.7 17754.9 17761.1 17771.0 40280.4 41645.8 42059.2 42300.4 42764.4 58298.1 59085.4 60214.8 60810.4 61402.7 8362.5 8386.6 8490.2 8596.1 8832.2 9429.6 11668.4 12229.8 13205.7 13369.5 10840.9 11252.3 11309.8 11414.0 11623.9 10553.3 11134.5 11305.9 11442.9 11657.4 11121.9 11790.8 11980.5 12081.9 12226.3 8483.4 8620.4 8661.0 8962.1 8962.6 11439.9 12087.3 12096.0 12124.6 12156.6 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#3] mootools.html Cycles:180 Average:5655.00 Median:2554.04 stddev:3164.89 (123.9%) stddev-sans-first:3158.46 23:18:12 INFO - PROCESS | 24097 | Values: 1513.0 1513.6 1667.8 1795.1 1806.1 7331.4 8031.7 8340.7 8585.1 8585.2 8307.6 8485.2 8555.4 8575.8 8599.8 2298.9 2326.5 2346.6 2358.8 2364.0 2274.1 2310.7 2337.1 2344.6 2363.1 2304.7 2310.9 2327.1 2350.0 2355.4 2225.2 2242.5 2244.2 2244.7 2250.8 2199.9 2208.5 2216.0 2231.0 2234.3 8519.0 8646.8 8657.7 8681.7 8691.6 5110.8 5219.5 5231.6 5236.9 5243.6 3212.5 3258.8 3400.9 3423.8 3428.7 1151.9 1184.1 2092.7 2134.6 2155.8 11853.5 11908.8 11954.0 12026.6 12085.3 4366.5 4465.4 4503.7 4529.1 4537.0 9498.2 9541.3 9553.0 9556.6 9564.4 5070.2 5154.4 5158.5 5162.8 5182.8 4099.8 4640.8 4769.6 4771.7 4775.5 3778.8 3784.3 3859.6 3860.4 3886.4 1146.7 1153.7 1159.5 1161.4 1165.5 868.8 1014.5 1026.9 1031.9 1088.4 6093.7 6103.5 6221.0 6265.3 6364.7 452.0 459.1 463.1 463.4 467.3 3760.7 3847.0 3859.2 3877.3 3941.6 10187.5 10450.9 10480.2 10542.5 10582.2 10580.5 10615.5 10652.6 10706.5 10757.3 7775.8 7876.6 7974.0 7986.9 8031.6 6062.1 6282.6 6315.4 6385.8 6399.8 9669.7 9688.2 9852.3 9868.4 10023.5 10076.6 10155.1 10197.2 10220.5 10224.8 6925.5 7318.4 7435.2 7772.9 7943.3 8191.3 8273.8 8298.0 8327.0 8363.5 6952.8 7149.8 7162.9 7211.6 7428.4 6918.6 6950.9 7040.2 7159.0 7180.7 6749.1 6782.2 6810.1 6817.2 6819.7 5004.1 5045.5 5144.4 5310.0 5333.4 5156.4 5289.7 5305.2 5323.1 5382.4 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#4] prototype.html Cycles:180 Average:4902.21 Median:5516.03 stddev:1467.04 (26.6%) stddev-sans-first:1430.29 23:18:12 INFO - PROCESS | 24097 | Values: 320.8 326.2 326.7 329.6 334.3 5453.5 5537.2 5601.3 5618.5 5678.8 5616.1 5632.7 5650.5 5658.3 5660.4 4322.0 4324.2 4333.7 4348.3 4389.4 4113.0 4302.7 4330.6 4400.5 4429.0 4261.4 4268.7 4284.3 4301.4 4327.2 4323.4 4324.7 4330.8 4334.2 4356.3 3591.9 3784.9 3794.7 3803.8 3808.8 5408.9 5418.3 5421.5 5450.3 5462.6 4919.0 4943.3 4945.2 4949.8 4983.8 5494.9 5856.9 5864.2 5886.2 5897.3 4109.6 4114.4 4115.9 4126.9 4134.2 6019.5 6086.3 6126.2 6126.5 6185.4 4123.2 4171.4 4201.8 4212.7 4221.0 4237.9 4244.3 4244.7 4259.4 4260.2 4855.6 4877.7 4887.7 4922.1 4949.5 5839.2 5897.4 5913.4 5941.2 5980.6 1462.7 1473.9 1475.3 1477.9 1485.1 878.3 921.3 926.9 939.6 951.6 4993.2 5030.5 5049.0 5072.9 5078.7 5326.8 5391.5 5453.1 5467.8 5474.2 5079.7 5096.7 5137.1 5274.6 5780.8 3223.0 3234.8 3255.0 3268.4 3274.7 6140.0 6228.9 6280.5 6283.8 6296.4 6177.8 6183.4 6202.9 6219.6 6222.5 6148.2 6151.6 6247.9 6278.5 6292.9 5857.5 5996.7 6096.6 6097.3 6135.9 6004.1 6033.5 6034.8 6041.8 6046.2 5920.6 6106.6 6190.4 6211.1 6245.5 4235.3 4240.7 4253.6 4273.1 4299.9 6148.1 6179.3 6187.2 6187.3 6206.8 5748.7 5899.8 5982.6 6010.9 6030.7 5879.3 5883.3 5914.9 5941.9 5971.2 5759.1 5825.5 5852.1 5897.8 5901.5 5766.4 5916.8 5945.3 5980.4 6002.4 5880.3 5888.8 5908.6 5915.1 5931.4 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - PROCESS | 24097 | [#5] yui.html Cycles:180 Average:19391.35 Median:27512.28 stddev:26493.92 (96.3%) stddev-sans-first:26531.11 23:18:12 INFO - PROCESS | 24097 | Values: 711.7 750.4 762.6 790.9 793.4 15352.7 15726.1 15992.2 16007.4 16068.0 14157.2 14217.6 14251.9 14302.1 14302.6 680.5 797.3 797.8 811.7 812.0 789.5 793.6 795.3 797.2 798.6 833.4 837.1 839.0 839.6 843.2 825.0 832.3 833.6 834.4 838.3 607.7 610.5 610.7 612.6 613.7 14333.4 14353.5 14365.0 14391.1 14421.5 14721.0 15114.8 15135.9 15270.2 15345.9 11912.5 11984.8 12090.6 12172.1 12606.1 3797.2 3947.3 3994.6 4029.6 4043.5 71132.6 72388.0 74812.0 74841.6 74857.6 11536.9 11555.1 11647.9 11708.6 11725.9 22145.3 22153.2 22338.9 22376.6 22476.6 7991.0 8085.7 8181.4 8521.1 8535.4 4394.6 4453.5 4492.8 4497.6 4497.9 3344.8 3454.7 3459.8 3462.4 3471.0 572.1 576.0 577.4 583.5 586.6 641.7 684.3 745.7 758.8 764.5 8401.6 8484.2 8609.8 8896.2 9185.6 641.2 699.7 705.3 747.9 780.4 4355.3 4448.9 4576.3 4670.1 4697.3 68518.0 69172.0 69345.7 69662.0 110075.4 94431.0 96753.5 97411.5 97682.0 97708.5 80892.0 82295.2 82835.0 82949.2 83269.0 8784.6 8979.7 8988.0 9008.5 9128.4 50327.2 50757.0 51869.0 52813.9 54284.5 64150.0 66608.0 67292.7 73998.0 78577.8 10659.6 10869.9 10887.7 12529.4 12546.7 14588.5 15028.6 15186.0 15201.0 16083.3 13882.5 14031.9 14087.4 14248.9 14475.9 13619.4 13636.9 14323.3 14427.6 14484.4 11535.8 13724.7 14101.6 14363.5 14390.4 10816.5 10982.3 11074.8 11180.7 11654.5 11001.6 11254.3 11507.3 11527.6 11528.1 23:18:12 INFO - PROCESS | 24097 | -------- Summary: end -------- 23:18:12 INFO - PROCESS | 24097 | 23:18:12 INFO - TEST-INFO | 24097: exit 0 23:18:12 INFO - TEST-OK | dromaeo_css | took 1112249ms 23:18:12 INFO - TEST-START | kraken 23:18:12 INFO - operating with platform_type : linux_ 23:18:12 INFO - Initialising browser for kraken test... 23:18:12 INFO - TEST-INFO | started process 24339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLkEAtl/profile http://localhost:38346/getInfo.html) 23:18:18 INFO - PROCESS | 24339 | __metrics Screen width/height:1600/1200 23:18:18 INFO - PROCESS | 24339 | colorDepth:24 23:18:18 INFO - PROCESS | 24339 | Browser inner width/height: 1024/697 23:18:18 INFO - PROCESS | 24339 | __metrics 23:18:19 ERROR - PROCESS | 24339 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:18:20 INFO - TEST-INFO | 24339: exit 0 23:18:20 INFO - Browser initialized. 23:18:20 INFO - Running cycle 1/1 for kraken test... 23:18:20 INFO - TEST-INFO | started process 24460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLkEAtl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:32 INFO - PROCESS | 24460 | RSS: Main: 167473152 23:18:32 INFO - PROCESS | 24460 | 23:18:34 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38346/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:35 INFO - PROCESS | 24460 | RSS: Main: 172658688 23:18:35 INFO - PROCESS | 24460 | 23:18:38 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38346/tests/kraken/driver.html?testName=audio-dft) 23:18:38 INFO - PROCESS | 24460 | RSS: Main: 172224512 23:18:38 INFO - PROCESS | 24460 | 23:18:41 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38346/tests/kraken/driver.html?testName=audio-fft) 23:18:42 INFO - PROCESS | 24460 | RSS: Main: 167432192 23:18:42 INFO - PROCESS | 24460 | 23:18:44 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38346/tests/kraken/driver.html?testName=audio-oscillator) 23:18:45 INFO - PROCESS | 24460 | RSS: Main: 167690240 23:18:45 INFO - PROCESS | 24460 | 23:18:47 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:47 INFO - PROCESS | 24460 | RSS: Main: 167849984 23:18:47 INFO - PROCESS | 24460 | 23:18:50 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38346/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:51 INFO - PROCESS | 24460 | RSS: Main: 167739392 23:18:51 INFO - PROCESS | 24460 | 23:18:55 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38346/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:55 INFO - PROCESS | 24460 | RSS: Main: 166043648 23:18:55 INFO - PROCESS | 24460 | 23:18:58 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38346/tests/kraken/driver.html?testName=json-parse-financial) 23:18:59 INFO - PROCESS | 24460 | RSS: Main: 167211008 23:18:59 INFO - PROCESS | 24460 | 23:19:00 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:19:01 INFO - PROCESS | 24460 | RSS: Main: 167841792 23:19:01 INFO - PROCESS | 24460 | 23:19:03 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:19:03 INFO - PROCESS | 24460 | RSS: Main: 168562688 23:19:03 INFO - PROCESS | 24460 | 23:19:05 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:19:06 INFO - PROCESS | 24460 | RSS: Main: 168546304 23:19:06 INFO - PROCESS | 24460 | 23:19:09 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:19:09 INFO - PROCESS | 24460 | RSS: Main: 168353792 23:19:09 INFO - PROCESS | 24460 | 23:19:12 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:19:13 INFO - PROCESS | 24460 | RSS: Main: 168218624 23:19:13 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | Cycle 1(1): loaded http://localhost:38346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38346/tests/kraken/driver.html?testName=ai-astar) 23:19:14 INFO - PROCESS | 24460 | RSS: Main: 168964096 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | __start_tp_report 23:19:14 INFO - PROCESS | 24460 | _x_x_mozilla_page_load 23:19:14 INFO - PROCESS | 24460 | _x_x_mozilla_page_load_details 23:19:14 INFO - PROCESS | 24460 | |i|pagename|runs| 23:19:14 INFO - PROCESS | 24460 | |0;ai-astar;113;105;112;111;111;111;111;111;111;110 23:19:14 INFO - PROCESS | 24460 | |1;audio-beat-detection;162;125;159;172;127;160;156;132;179;136 23:19:14 INFO - PROCESS | 24460 | |2;audio-dft;164;162;164;161;161;167;172;163;162;162 23:19:14 INFO - PROCESS | 24460 | |3;audio-fft;75;74;74;155;74;75;76;75;178;76 23:19:14 INFO - PROCESS | 24460 | |4;audio-oscillator;85;84;142;86;85;86;147;86;85;139 23:19:14 INFO - PROCESS | 24460 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;118;118 23:19:14 INFO - PROCESS | 24460 | |6;imaging-darkroom;147;147;147;147;147;146;146;145;146;145 23:19:14 INFO - PROCESS | 24460 | |7;imaging-desaturate;95;96;95;95;96;95;95;96;95;96 23:19:14 INFO - PROCESS | 24460 | |8;json-parse-financial;53;54;56;54;54;53;54;53;54;54 23:19:14 INFO - PROCESS | 24460 | |9;json-stringify-tinderbox;63;64;63;63;64;63;63;63;63;63 23:19:14 INFO - PROCESS | 24460 | |10;stanford-crypto-aes;81;79;80;82;80;79;81;86;109;81 23:19:14 INFO - PROCESS | 24460 | |11;stanford-crypto-ccm;138;122;135;121;126;125;130;126;129;138 23:19:14 INFO - PROCESS | 24460 | |12;stanford-crypto-pbkdf2;166;162;167;160;160;160;158;163;159;175 23:19:14 INFO - PROCESS | 24460 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;63;63;63;62;61 23:19:14 INFO - PROCESS | 24460 | __end_tp_report 23:19:14 INFO - PROCESS | 24460 | __start_cc_report 23:19:14 INFO - PROCESS | 24460 | _x_x_mozilla_cycle_collect,883 23:19:14 INFO - PROCESS | 24460 | __end_cc_report 23:19:14 INFO - PROCESS | 24460 | __startTimestamp1465366754979__endTimestamp 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | ------- Summary: start ------- 23:19:14 INFO - PROCESS | 24460 | Number of tests: 14 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.06 23:19:14 INFO - PROCESS | 24460 | Values: 113.0 105.0 112.0 111.0 111.0 111.0 111.0 111.0 111.0 110.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:159.50 stddev:19.30 (12.1%) stddev-sans-first:20.04 23:19:14 INFO - PROCESS | 24460 | Values: 162.0 125.0 159.0 172.0 127.0 160.0 156.0 132.0 179.0 136.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.39 (2.1%) stddev-sans-first:3.60 23:19:14 INFO - PROCESS | 24460 | Values: 164.0 162.0 164.0 161.0 161.0 167.0 172.0 163.0 162.0 162.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:39.02 (52.0%) stddev-sans-first:40.83 23:19:14 INFO - PROCESS | 24460 | Values: 75.0 74.0 74.0 155.0 74.0 75.0 76.0 75.0 178.0 76.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.79 (32.7%) stddev-sans-first:28.75 23:19:14 INFO - PROCESS | 24460 | Values: 85.0 84.0 142.0 86.0 85.0 86.0 147.0 86.0 85.0 139.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:19:14 INFO - PROCESS | 24460 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 118.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 23:19:14 INFO - PROCESS | 24460 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 146.0 145.0 146.0 145.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:19:14 INFO - PROCESS | 24460 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.87 23:19:14 INFO - PROCESS | 24460 | Values: 53.0 54.0 56.0 54.0 54.0 53.0 54.0 53.0 54.0 54.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 23:19:14 INFO - PROCESS | 24460 | Values: 63.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 23:19:14 INFO - PROCESS | 24460 | 23:19:14 INFO - PROCESS | 24460 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:9.08 (11.2%) stddev-sans-first:9.57 23:19:14 INFO - PROCESS | 24460 | Values: 81.0 79.0 80.0 82.0 80.0 79.0 81.0 86.0 109.0 81.0 23:19:15 INFO - PROCESS | 24460 | 23:19:15 INFO - PROCESS | 24460 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:129.50 stddev:6.20 (4.8%) stddev-sans-first:5.66 23:19:15 INFO - PROCESS | 24460 | Values: 138.0 122.0 135.0 121.0 126.0 125.0 130.0 126.0 129.0 138.0 23:19:15 INFO - PROCESS | 24460 | 23:19:15 INFO - PROCESS | 24460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:162.50 stddev:5.14 (3.2%) stddev-sans-first:5.34 23:19:15 INFO - PROCESS | 24460 | Values: 166.0 162.0 167.0 160.0 160.0 160.0 158.0 163.0 159.0 175.0 23:19:15 INFO - PROCESS | 24460 | 23:19:15 INFO - PROCESS | 24460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 23:19:15 INFO - PROCESS | 24460 | Values: 63.0 63.0 63.0 64.0 62.0 63.0 63.0 63.0 62.0 61.0 23:19:15 INFO - PROCESS | 24460 | -------- Summary: end -------- 23:19:15 INFO - PROCESS | 24460 | 23:19:15 INFO - TEST-INFO | 24460: exit 0 23:19:15 INFO - TEST-OK | kraken | took 63113ms 23:19:15 INFO - SUITE-END | took 1175s 23:19:16 INFO - Completed test suite (00:19:35) 23:19:16 INFO - javascript benchmark 23:19:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7171.328948966388, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.7807053506253, 3187.2191313128287, 3200.5839240898695, 3222.822744749038, 3234.7250483708885, 5416.404195538487, 5428.430014848438, 5441.428649991753, 5453.154761012044, 5473.261109750182, 5358.223057656637, 5422.6475279106835, 5438.075527160382, 5458.890822183554, 5490.945090549093, 4879.438864530571, 4909.803607855682, 5016.27264046713, 5063.898722025558, 5091.261767043777, 812.1973637152594, 4931.802727890898, 5024.698518088908, 5052.469490703478, 5053.1157047516535, 4955.231939049453, 4977.203647416414, 4978.850634480971, 4991.251312303148, 5038.39539255288, 4831.782569784333, 5003.099442100421, 5016.623753218523, 5029.899402011939, 5080.542751152414, 4869.805207791684, 4932.235503496964, 4932.556069953722, 4937.580305674022, 4950.183219768734, 5317.73411329432, 5385.515303622654, 5404.405515393303, 5425.02349577076, 5426.375966763794, 5715.114157305583, 5758.539316854642, 5882.794102206445, 5893.381194974551, 5895.675737834417, 5754.647657800414, 5761.135829625548, 5773.422657734235, 5783.5951483396175, 5794.478496935254, 5400.0, 5407.810726624589, 5415.268938693265, 5423.267858839045, 5433.1035379162395, 5800.796972105956, 5856.677882716492, 5871.823845284648, 5893.882122357529, 5903.704814759245, 5700.287464066992, 5764.452377024176, 5775.537956963432, 5785.971070144622, 5825.1844741736195, 5843.707814609337, 5859.648421094748, 5860.736266868002, 5861.120831875252, 5866.501347385435, 5684.9431505684415, 5770.6249093808765, 5848.093545500455, 5851.210086638334, 5870.677112758839, 5720.914186287209, 5836.270466191726, 5867.325257595431, 5907.556933229939, 5982.222311099529, 4458.041521072985, 4496.437945256843, 4507.233770258998, 4507.571780680895, 4553.977230113828, 3906.4140378942816, 3943.2902077626304, 3973.4635824163947, 4003.939940900889, 4058.736182148151, 5640.069388550925, 5642.322921249394, 5644.379118296984, 5646.830595082154, 5694.886102277931, 5866.6186697864505, 5963.224780778471, 5965.343812180657, 5972.731227094791, 5988.401159883977, 5359.866003349947, 5583.246261754693, 5597.384287728347, 5638.464345887216, 5638.830835074954, 5077.847664570068, 5082.313887625197, 5091.618128640367, 5098.056859481007, 5109.56568691658, 6058.091286307089, 6076.939230607726, 6094.268687757498, 6099.268087829489, 6117.510599152057, 5709.486146246774, 5869.882602347929, 5890.528757699288, 5922.585419020799, 5964.165016897725, 6073.362296958756, 6081.756729730761, 6088.086786981989, 6100.176476175659, 6113.113598528277, 5564.443555644403, 5804.593678442468, 5845.883082338414, 5853.678047707247, 5866.7066646668345, 5821.79623713168, 5864.354920958776, 5883.176355310175, 5895.882082358415, 5899.823005309676, 5685.857853553529, 5709.172170035238, 5757.453041961007, 5767.134929760569, 5772.336181339199, 5572.498475137257, 5617.269754931833, 5679.290088738908, 5739.540836733135, 5746.9712651436475, 5428.4842939920645, 5512.283403157564, 5593.133064375028, 5598.972005139948, 5667.659940403589, 5770.076787713946, 5817.709114544171, 5833.358330583717, 5843.678597677169, 5844.094165404369, 5434.75543600531, 5549.805756798492, 5695.7436915338085, 5701.543876489788, 5708.714564271853], "value": 5366.038859382849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.178985840107, 637.7321524959517, 640.8590110175762, 647.9481641468682, 648.0473703655628, 33656.0, 36273.63726362739, 44102.999999999956, 45323.0, 45503.54496455035, 45395.31907021398, 46208.30687539681, 46228.0, 46323.0, 46347.84130396742, 8545.572721363938, 8625.439346442461, 8660.133986601353, 8696.304295656364, 8705.173008564176, 8791.912080879174, 8900.910990890074, 8932.732018039436, 8935.508547029944, 8967.103289671013, 8935.687250946217, 8959.865602015941, 8969.865452018224, 8976.147266009719, 9015.413998090136, 8866.379353445262, 8982.640694372218, 8990.415622984485, 8992.820143597091, 9027.368084234138, 8802.471851688855, 8945.955270223672, 8948.418352807112, 8951.328650351184, 8975.237104846095, 40312.79843600763, 40433.797831010954, 40581.59418405808, 40632.39051414231, 40683.0, 3503.4744788281705, 3545.840437180307, 3570.5179800727087, 3602.343621224459, 3629.709623230135, 29927.551086733718, 32414.0, 32417.837910810296, 32423.837880810446, 32429.51355729666, 4395.252807022814, 4475.1944649963, 4503.497620021752, 4546.227141385973, 4631.791569379352, 349233.0, 352063.63649999496, 353624.0, 355230.0, 356729.0, 35010.82494587562, 62578.0, 62947.37052629507, 63031.68484157642, 63048.36951630425, 37159.25681486409, 37358.43962340567, 37503.249935001695, 37525.437118443246, 37643.43534846979, 14898.404063837324, 15094.094354338555, 15115.773263401057, 15122.243887805786, 15162.924185379003, 13253.933730331286, 13484.325783710776, 13495.325233738471, 13539.323033848268, 13548.051636385555, 8438.113998030118, 8504.659813607386, 8506.276966457921, 8540.487570745776, 8585.441946273597, 3234.7573931954726, 3259.282957749291, 3288.9506657400157, 3294.736421086355, 3302.3725492156414, 1008.626808081, 1044.2794471814423, 1049.5906596427399, 1096.4024606589428, 1150.206357613244, 33488.8278910237, 33589.66410335866, 33636.49545256823, 33831.32337353288, 33848.66151338504, 1131.1007748839693, 1141.9371934543515, 1154.1978325064, 1169.1231576317762, 1228.7235372041398, 16952.321907123824, 17598.863884640552, 17659.55851103707, 17677.7348339775, 17678.11609419524, 615956.0, 624707.0, 625255.0, 626213.4757304828, 628399.0, 60368.39631603716, 60570.69714651399, 61140.38859611436, 61184.38815611876, 61191.69404152951, 1290.2065229883553, 1374.3815283122635, 1389.0485017762865, 1389.2567476400077, 1389.5275606293908, 30491.39017219599, 32836.179095522806, 33222.52863282919, 33297.0, 33336.33327333488, 52288.21567676412, 52604.736976314874, 52851.207231892324, 52927.73536132295, 53224.0, 482848.0, 483507.0, 485016.0, 487718.0, 489728.0, 28370.71629283681, 28530.144095677162, 28569.28576785597, 28753.281167970967, 28946.276343090747, 48783.75608121937, 49023.26465103098, 49811.25283120829, 49865.25202122044, 50145.0, 40858.0, 41720.79139604283, 41937.0, 42060.36909446299, 42075.7896210517, 40929.38605920854, 41412.171756564094, 41793.37309940414, 41834.37248441337, 41885.37171942362, 40945.59054409537, 41506.0, 41554.36450970394, 41630.0, 41923.0, 35241.29517409586, 36848.0, 37052.81473592615, 37418.812905936386, 37726.0, 28699.0, 28914.132576022752, 28936.421271574873, 28949.855250723613, 29166.708332916398], "value": 19341.724491465506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.30602303807063, 381.452615496762, 384.3351002765216, 399.96600288975435, 400.1097557933596, 16924.661506769873, 18808.43574692758, 18946.147423365946, 19032.61934761304, 19163.808361916377, 10942.343459392441, 11703.0, 18783.62432751344, 19128.61742765144, 19186.520336991583, 5038.6724862883975, 5164.974175129119, 5202.297689811865, 5215.6349055566125, 5223.190405487156, 3863.652271295583, 5560.999020176367, 5813.767449302023, 5832.037713777222, 5930.822075337725, 5618.297712785902, 5742.196092547026, 5811.476967072963, 5836.095405212178, 5844.035734103868, 5806.854828629276, 5856.209411729405, 5881.088431293157, 5900.67546284952, 5905.940940590582, 5532.391436941974, 5673.716314184274, 5704.286964129484, 5718.5425165987035, 5724.141378793172, 13464.730705385935, 13478.730425391535, 13522.12106213093, 13593.728125437534, 21671.0, 2064.370367038053, 2171.9239826605994, 2214.5460180662926, 2228.387193521778, 2376.5484557933937, 9364.484953327565, 9480.857787133198, 9559.0, 9815.41107533543, 9850.408975461496, 1800.2349001674236, 1846.4645252876649, 1875.3998720409475, 1913.9521511962173, 1936.893470859102, 65262.67368663174, 82383.58808205981, 82569.58715206446, 85158.0, 86764.13235867623, 10172.542235599416, 10344.0, 10404.479776011169, 10429.895701042893, 10551.788964220672, 14301.64245893861, 14307.78538321926, 14729.189894555688, 14734.63163420923, 14908.776368354484, 7622.733204337933, 8000.759977200693, 8013.358931285483, 8124.471909325875, 8140.918590814016, 7791.922080779233, 7827.0, 7851.882221766678, 7951.244631759973, 7964.920350796418, 4304.956950430518, 4371.825126994884, 4422.535633758409, 4428.092241090633, 4570.0, 1515.726789496828, 1636.443609172863, 1641.6880792649358, 1648.826873178323, 1650.521348808856, 927.2720914082413, 966.970990870275, 1039.875214974208, 1070.9558180773683, 1139.641013080877, 18250.81749182518, 18518.259269629332, 18839.340623078126, 19093.331733389266, 19278.614427711367, 1000.5847573257163, 1003.814294355532, 1016.1159790981893, 1019.3119644240109, 1067.0396643021343, 10192.694219173436, 10636.202284828514, 10746.94626526878, 10765.946170269099, 10781.892181078245, 488045.0, 489619.0, 490010.0, 501430.0, 502175.0, 87972.12027879768, 94062.5296873525, 98215.50892245636, 100456.0, 102040.44898877587, 1008.6671398438498, 1028.2956175020136, 1056.1920131099714, 1059.4914441068177, 1073.88187299397, 17355.47933561995, 17383.739243911605, 17754.91122544379, 17761.11194440247, 17771.0, 40280.3957940637, 41645.79177104216, 42059.15881682288, 42300.36549451699, 42764.358534622625, 58298.12552811796, 59085.40914590971, 60214.83877095007, 60810.39189608224, 61402.692986534785, 8362.498250105013, 8386.580670966548, 8490.23587877094, 8596.054434012378, 8832.160944710242, 9429.57566909477, 11668.416579171177, 12229.75540489203, 13205.669858253621, 13369.53206637763, 10840.891591083988, 11252.324860508395, 11309.830352544883, 11414.0, 11623.883761162619, 10553.314034587727, 11134.498947547218, 11305.943470282597, 11442.94278528602, 11657.358845263592, 11121.944390277997, 11790.823137653113, 11980.520779168735, 12081.879181208076, 12226.327551984727, 8483.406161568631, 8620.396572240134, 8661.0, 8962.14859588338, 8962.596683149144, 11439.942800285946, 12087.335196563921, 12096.0, 12124.636260912186, 12156.635300940987], "value": 8903.15917096883, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.0467805282672, 1513.6291608555905, 1667.808202056763, 1795.1114198471757, 1806.1420825108066, 7331.376832969191, 8031.718889838857, 8340.666373345059, 8585.098564650707, 8585.184407481287, 8307.626156822942, 8485.236328730412, 8555.358348123884, 8575.78560535987, 8599.828003439943, 2298.8965496552696, 2326.4765427778784, 2346.6010778167665, 2358.7995020423286, 2364.0, 2274.0789980058103, 2310.6649535817296, 2337.1118974789556, 2344.5896968030524, 2363.1492662641435, 2304.7349554801244, 2310.8844557772127, 2327.0575416956076, 2350.0364850411333, 2355.3875992242056, 2225.2100504320897, 2242.4842286274247, 2244.236959433792, 2244.7194100737406, 2250.7524172340945, 2199.9340019799433, 2208.4699672078746, 2215.9778402215934, 2230.988845055764, 2234.296196698051, 8518.957405212934, 8646.783830404227, 8657.696980605648, 8681.652733890636, 8691.608877600524, 5110.770015349318, 5219.5041471060185, 5231.555317797992, 5236.869078273074, 5243.632945693803, 3212.4538828399227, 3258.7881787683964, 3400.863965441379, 3423.845926933294, 3428.6914177723875, 1151.890570395811, 1184.09416796151, 2092.696558998952, 2134.594427058854, 2155.8167555757777, 11853.46659400329, 11908.821367679491, 11953.983911367544, 12026.579069732517, 12085.27488350693, 4366.476022877211, 4465.441819772528, 4503.684742068024, 4529.13946350199, 4536.954630453653, 9498.19265362452, 9541.284403669753, 9552.95223523878, 9556.617735290649, 9564.426134431957, 5070.2141168119, 5154.355705536808, 5158.484151584811, 5162.793488260502, 5182.844514664566, 4099.815508302134, 4640.791164397543, 4769.594584460359, 4771.665983381199, 4775.5224477551965, 3778.848846046127, 3784.262068896594, 3859.5754467008605, 3860.3823388257742, 3886.436466712311, 1146.7419830538063, 1153.6827372472637, 1159.5072094359864, 1161.4018780328138, 1165.5279611757082, 868.843608150539, 1014.5282443663732, 1026.8511065895402, 1031.8555402243692, 1088.357868857362, 6093.725782339805, 6103.450689437972, 6221.0, 6265.310815810257, 6364.7135878885565, 451.95028546859817, 459.10932790386545, 463.10158292911643, 463.4137815663189, 467.29438547793075, 3760.7367484276383, 3846.9615303847163, 3859.150986782903, 3877.3020856245585, 3941.6452519273403, 10187.490625468698, 10450.947745261225, 10480.161587073168, 10542.525586348633, 10582.153427725763, 10580.52387642558, 10615.52230149645, 10652.62715804943, 10706.518206680717, 10757.30077544957, 7775.844483110306, 7876.645550950221, 7974.0, 7986.880196797053, 8031.638576264082, 6062.090686397076, 6282.560220784501, 6315.431611155018, 6385.840353991188, 6399.8080057598345, 9669.661561845302, 9688.176504997155, 9852.261080418853, 9868.358556693793, 10023.498825058572, 10076.647317343857, 10155.086042255936, 10197.23520735933, 10220.488975551341, 10224.846627300447, 6925.480588955949, 7318.377937875341, 7435.219301973431, 7772.92227077722, 7943.285104340637, 8191.344692424711, 8273.83452330962, 8298.045724741733, 8326.958365208135, 8363.540005299523, 6952.826179345557, 7149.785506434815, 7162.89255661155, 7211.567305961449, 7428.442866784904, 6918.584884906922, 6950.930490695028, 7040.155181378267, 7159.0, 7180.712771489082, 6749.055132281583, 6782.152230971129, 6810.114685090906, 6817.181938167451, 6819.659017049227, 5004.099262132851, 5045.495450455072, 5144.434112247575, 5310.0, 5333.386660534088, 5156.381234251914, 5289.68261904287, 5305.230741542532, 5323.1216849219445, 5382.381026182039], "value": 4515.453804151332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.77866272272115, 326.15037826462066, 326.74350634751727, 329.6456309467322, 334.28629875216404, 5453.481919217678, 5537.197106419567, 5601.29983752031, 5618.4943355098085, 5678.801241956532, 5616.101423772197, 5632.690202038896, 5650.463205995434, 5658.264425624663, 5660.377358490573, 4322.0, 4324.156789426047, 4333.739975601474, 4348.304161377066, 4389.363542286366, 4112.97943510282, 4302.741835489881, 4330.631896288819, 4400.471943366801, 4429.0, 4261.382099595557, 4268.658507319407, 4284.335927931175, 4301.419308393374, 4327.199468098396, 4323.3947247385395, 4324.718893271927, 4330.805113769888, 4334.219840428722, 4356.259435895905, 3591.892243232707, 3784.9432258516144, 3794.696424286078, 3803.7527560708463, 3808.7905165215902, 5408.945910540923, 5418.295621569171, 5421.539169170625, 5450.29146210994, 5462.644928079662, 4918.96701692645, 4943.258511223309, 4945.184044632631, 4949.7772600233075, 4983.825566105169, 5494.862628434281, 5856.853578660525, 5864.179014937912, 5886.20536227608, 5897.292324920994, 4109.589041095896, 4114.444549985774, 4115.8971025724595, 4126.91746165078, 4134.214499245134, 6019.4883434908525, 6086.300075491286, 6126.23422072241, 6126.540509461764, 6185.381461853824, 4123.237201117803, 4171.353440216772, 4201.781483369849, 4212.662986961036, 4220.978895105505, 4237.87286381409, 4244.257254980366, 4244.681648876347, 4259.382389553497, 4260.211860805699, 4855.635827312965, 4877.707337559757, 4887.706737595756, 4922.114019476457, 4949.48030456804, 5839.204950608593, 5897.380775018647, 5913.438223368859, 5941.168236446901, 5980.641161530322, 1462.676277968419, 1473.8747206487353, 1475.32135217801, 1477.9432705615536, 1485.123776971592, 878.2622597018535, 921.2952091649893, 926.8980412154658, 939.6335429182624, 951.619352259088, 4993.151164302005, 5030.547250747451, 5049.005642771085, 5072.873178170502, 5078.7460626968505, 5326.813561525328, 5391.487808658171, 5453.127499600045, 5467.840203119746, 5474.233607294982, 5079.74601269935, 5096.745162741848, 5137.0701413418765, 5274.57369609976, 5780.768769249267, 3223.0, 3234.7897386669792, 3255.0, 3268.4280250956463, 3274.6561611030497, 6140.0, 6228.8788018156265, 6280.466160376419, 6283.7800676976085, 6296.370362963667, 6177.84555386119, 6183.443490085914, 6202.906956395657, 6219.595726277777, 6222.471089957314, 6148.200733904474, 6151.569390142647, 6247.937520624736, 6278.524546731514, 6292.937070629327, 5857.531397488276, 5996.67018313997, 6096.622317296346, 6097.32929377777, 6135.877282454415, 6004.099385092271, 6033.456988871023, 6034.849128771816, 6041.848953776191, 6046.2139921809885, 5920.644761314335, 6106.572539922163, 6190.41191086846, 6211.13044173807, 6245.500359971283, 4235.30117530604, 4240.681948853787, 4253.595908388698, 4273.059926816096, 4299.892502687333, 6148.139260503443, 6179.3202747698615, 6187.226596675416, 6187.257529096537, 6206.844828879314, 5748.6838223898085, 5899.849529341737, 5982.581219314607, 6010.909836352545, 6030.7286172121485, 5879.323877754113, 5883.323417807007, 5914.940850591439, 5941.940580594139, 5971.164037034905, 5759.0605264599635, 5825.50483208932, 5852.092925596539, 5897.764089436375, 5901.498372638373, 5766.365699772938, 5916.763329466945, 5945.286565612154, 5980.401959803985, 6002.429769171922, 5880.294714532738, 5888.793892213752, 5908.645481271137, 5915.112733089899, 5931.436513531207], "value": 4424.401298616808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7010855440715, 750.4334227658119, 762.6377470701417, 790.9248621380967, 793.3890904003913, 15352.692946141071, 15726.056436613811, 15992.200389980513, 16007.359705611761, 16068.0, 14157.150570965749, 14217.644558886033, 14251.928740356283, 14302.07036542624, 14302.57092287233, 680.4760334542399, 797.2784629909926, 797.7766225456882, 811.6875003123811, 811.9918800812005, 789.4631650477672, 793.5952664141272, 795.2921899509412, 797.2227078598349, 798.5647821937058, 833.3749687734199, 837.0583094019229, 839.0225387423644, 839.5969934431477, 843.1652663862762, 824.9752507424787, 832.3258160889638, 833.62903507939, 834.390894646905, 838.2748922182299, 607.6506009044817, 610.4902406490586, 610.7434877351478, 612.5987478201785, 613.7268915332679, 14333.354999025069, 14353.497627583089, 14365.0, 14391.064580802215, 14421.495247666282, 14721.0, 15114.848851511455, 15135.924320378437, 15270.16014119223, 15345.923270383577, 11912.523499060027, 11984.820227696591, 12090.637280881587, 12172.087093468026, 12606.117571769979, 3797.2215695782297, 3947.3486874665646, 3994.6205110514456, 4029.5567487576345, 4043.5349934757587, 71132.6443367785, 72388.0, 74812.0, 74841.62579187124, 74857.62571187163, 11536.884631153749, 11555.075593952464, 11647.941760291144, 11708.590199342982, 11725.941370293265, 22145.33563993083, 22153.224637137624, 22338.888305558692, 22376.55246895053, 22476.55046899053, 7991.041075071029, 8085.676572937135, 8181.3863960203225, 8521.062683104854, 8535.402521823537, 4394.582514661102, 4453.465584129925, 4492.842750503717, 4497.617702495259, 4497.910041799146, 3344.8494817733263, 3454.7408944329277, 3459.7924124552605, 3462.428699264593, 3471.0454624978333, 572.0760971031837, 576.0380165124252, 577.4456521739094, 583.4777873802923, 586.6450797267677, 641.6887809412431, 684.3122661725034, 745.6532712288812, 758.8102974256436, 764.5221736414741, 8401.579921004048, 8484.15158484159, 8609.827803443895, 8896.243819275434, 9185.63257469707, 641.1568787045021, 699.6921354603958, 705.2806137739477, 747.872861613527, 780.4479352517237, 4355.259605867011, 4448.888777780581, 4576.26779715244, 4670.136024835417, 4697.31888876111, 68518.0, 69172.0, 69345.65327173332, 69662.0, 110075.44962275297, 94431.0, 96753.51623241839, 97411.51294243483, 97682.0, 97708.51145744367, 80892.0, 82295.17704822995, 82835.0, 82949.17050829415, 83269.0, 8784.604692788967, 8979.730608081769, 8987.955060224918, 9008.459492430475, 9128.361014729171, 50327.245091322926, 50757.0, 51869.0, 52813.94372112613, 54284.45715542794, 64150.0, 66608.0, 67292.66353668396, 73998.0, 78577.82133267891, 10659.573617055232, 10869.945650271698, 10887.727806804893, 12529.436175372313, 12546.749065018832, 14588.489402870848, 15028.647421732097, 15186.0, 15201.0, 16083.276252568428, 13882.51411200603, 14031.929840350733, 14087.436502539784, 14248.928755356157, 14475.85524144745, 13619.387127579084, 13636.931815341257, 14323.283835807959, 14427.567172984827, 14484.420623174956, 11535.8269625954, 13724.65688357759, 14101.576952691436, 14363.497277595234, 14390.424383024561, 10816.513256903301, 10982.254436390902, 11074.833877491683, 11180.664580062612, 11654.501581211625, 11001.61494347694, 11254.29681848335, 11507.309561426342, 11527.596534121265, 11528.135389845962], "value": 7367.272279617632, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 159.0, 172.0, 127.0, 160.0, 156.0, 132.0, 179.0, 136.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 161.0, 161.0, 167.0, 172.0, 163.0, 162.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 155.0, 74.0, 75.0, 76.0, 75.0, 178.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 142.0, 86.0, 85.0, 86.0, 147.0, 86.0, 85.0, 139.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 82.0, 80.0, 79.0, 81.0, 86.0, 109.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 122.0, 135.0, 121.0, 126.0, 125.0, 130.0, 126.0, 129.0, 138.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 167.0, 160.0, 160.0, 160.0, 158.0, 163.0, 159.0, 175.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 62.0, 61.0], "value": 62.7, "unit": "score"}]}]} 23:19:16 INFO - Return code: 0 23:19:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:19:16 ERROR - # TBPL SUCCESS # 23:19:16 INFO - Running post-action listener: _resource_record_post_action 23:19:16 INFO - ##### 23:19:16 INFO - ##### Finished run-tests step (success) 23:19:16 INFO - ##### 23:19:16 INFO - Running post-run listener: _resource_record_post_run 23:19:16 INFO - Total resource usage - Wall time: 1193s; CPU: 14.0%; Read bytes: 4096; Write bytes: 540360704; Read time: 12; Write time: 1159028 23:19:16 INFO - TinderboxPrint: CPU usage
13.5% 23:19:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:19:16 INFO - TinderboxPrint: I/O write bytes / time
540,360,704 / 1,159,028 23:19:16 INFO - TinderboxPrint: CPU idle
8,232.1 (86.5%) 23:19:16 INFO - TinderboxPrint: CPU user
1,222.8 (12.8%) 23:19:16 INFO - TinderboxPrint: Swap in / out
0 / 0 23:19:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248016896; Read time: 0; Write time: 498288 23:19:16 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 4096; Write bytes: 292167680; Read time: 12; Write time: 660736 23:19:16 INFO - Running post-run listener: _upload_blobber_files 23:19:16 INFO - Blob upload gear active. 23:19:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:19:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:19:17 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:19:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:17 INFO - (blobuploader) - INFO - Done attempting. 23:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:18 INFO - (blobuploader) - INFO - Done attempting. 23:19:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:19:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:23 INFO - (blobuploader) - INFO - Done attempting. 23:19:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:23 INFO - Return code: 0 23:19:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:19:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901ea59e7d0039ed66f318fd0294eb8d6fbb1f7676618663e93349e0739b5e805f7c5a2d165a777b213d4bb83e77db9fbd5b73f84d9bc4e4691e42b65aba78c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c011f43c62279556d0ec652b575568a2feecceaef8e40ace1d7b0141f47ddf781d6b26dae27d13b03c4174671f0396ad69245518ea522512aa973b4dce1939c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05bfd1af8ec65914fa6f597e25b03484526580842609364962856ffb753bf1e78603a239848ff966bbdba6056d8a4a05af3ea9b28af129185960975e2c5447cb"} 23:19:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:19:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:19:23 INFO - Contents: 23:19:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/901ea59e7d0039ed66f318fd0294eb8d6fbb1f7676618663e93349e0739b5e805f7c5a2d165a777b213d4bb83e77db9fbd5b73f84d9bc4e4691e42b65aba78c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c011f43c62279556d0ec652b575568a2feecceaef8e40ace1d7b0141f47ddf781d6b26dae27d13b03c4174671f0396ad69245518ea522512aa973b4dce1939c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05bfd1af8ec65914fa6f597e25b03484526580842609364962856ffb753bf1e78603a239848ff966bbdba6056d8a4a05af3ea9b28af129185960975e2c5447cb"} 23:19:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:19:23 INFO - Copying logs to upload dir... 23:19:23 INFO - mkdir: /builds/slave/test/build/upload/logs 23:19:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.535732 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-07 23:19:22.963328) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:22.966905) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 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/sha512/901ea59e7d0039ed66f318fd0294eb8d6fbb1f7676618663e93349e0739b5e805f7c5a2d165a777b213d4bb83e77db9fbd5b73f84d9bc4e4691e42b65aba78c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c011f43c62279556d0ec652b575568a2feecceaef8e40ace1d7b0141f47ddf781d6b26dae27d13b03c4174671f0396ad69245518ea522512aa973b4dce1939c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05bfd1af8ec65914fa6f597e25b03484526580842609364962856ffb753bf1e78603a239848ff966bbdba6056d8a4a05af3ea9b28af129185960975e2c5447cb"} build_url:https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/FEi06RDARjWL9aVedZ5jtQ/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/sha512/901ea59e7d0039ed66f318fd0294eb8d6fbb1f7676618663e93349e0739b5e805f7c5a2d165a777b213d4bb83e77db9fbd5b73f84d9bc4e4691e42b65aba78c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c011f43c62279556d0ec652b575568a2feecceaef8e40ace1d7b0141f47ddf781d6b26dae27d13b03c4174671f0396ad69245518ea522512aa973b4dce1939c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05bfd1af8ec65914fa6f597e25b03484526580842609364962856ffb753bf1e78603a239848ff966bbdba6056d8a4a05af3ea9b28af129185960975e2c5447cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:22.994910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:22.995670) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465364945.508964-430818212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 23:19:23.077756) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 23:19:23.078452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 23:19:23.079125) ========= ========= Total master_lag: 0.20 =========