builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1464788265.0 results: success (0) buildid: 20160601055046 builduid: f1483944f64a4a3c8e2dce3f8263d3f6 revision: 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:44.999560) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.000442) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.001015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.019502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.019859) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 06:37:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-01 06:37:45 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.138663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.139034) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:45.195423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 06:37:45.195916) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e --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 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e --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=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 06:37:45,258 truncating revision to first 12 chars 2016-06-01 06:37:45,258 Setting DEBUG logging. 2016-06-01 06:37:45,258 attempt 1/10 2016-06-01 06:37:45,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ca8ea4f429a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 06:37:46,251 unpacking tar archive at: fx-team-5ca8ea4f429a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-01 06:37:46.566404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:46.566794) ========= script_repo_revision: 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:46.567227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:46.567535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 06:37:46.582388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-01 06:37:46.582736) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:37:46 INFO - MultiFileLogger online at 20160601 06:37:46 in /builds/slave/test 06:37:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:37:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:37:46 INFO - {'append_to_log': False, 06:37:46 INFO - 'base_work_dir': '/builds/slave/test', 06:37:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:37:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:37:46 INFO - 'branch': 'Fx-Team-Non-PGO', 06:37:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:37:46 INFO - 'config_files': ('talos/linux_config.py',), 06:37:46 INFO - 'default_actions': ('clobber', 06:37:46 INFO - 'read-buildbot-config', 06:37:46 INFO - 'download-and-extract', 06:37:46 INFO - 'populate-webroot', 06:37:46 INFO - 'create-virtualenv', 06:37:46 INFO - 'install', 06:37:46 INFO - 'run-tests'), 06:37:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:37:46 INFO - 'download_minidump_stackwalk': True, 06:37:46 INFO - 'download_symbols': 'ondemand', 06:37:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:37:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:37:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:37:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:37:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:37:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:37:46 INFO - 'installer_path': 'installer.exe', 06:37:46 INFO - 'log_level': 'info', 06:37:46 INFO - 'log_name': 'talos', 06:37:46 INFO - 'log_to_console': True, 06:37:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:37:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:37:46 INFO - 'opt_config_files': (), 06:37:46 INFO - 'pip_index': False, 06:37:46 INFO - 'sps_profile': False, 06:37:46 INFO - 'sps_profile_interval': 0, 06:37:46 INFO - 'suite': 'dromaeojs', 06:37:46 INFO - 'system_bits': '32', 06:37:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:37:46 INFO - 'title': 'talos-linux64-ix-001', 06:37:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:37:46 INFO - 'use_talos_json': True, 06:37:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:37:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:37:46 INFO - 'work_dir': 'build'} 06:37:46 INFO - ##### 06:37:46 INFO - ##### Running clobber step. 06:37:46 INFO - ##### 06:37:46 INFO - Running pre-action listener: _resource_record_pre_action 06:37:46 INFO - Running main action method: clobber 06:37:46 INFO - rmtree: /builds/slave/test/build 06:37:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - ##### 06:37:47 INFO - ##### Finished clobber step (success) 06:37:47 INFO - ##### 06:37:47 INFO - ##### 06:37:47 INFO - ##### Running read-buildbot-config step. 06:37:47 INFO - ##### 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: read_buildbot_config 06:37:47 INFO - Using buildbot properties: 06:37:47 INFO - { 06:37:47 INFO - "project": "", 06:37:47 INFO - "product": "firefox", 06:37:47 INFO - "script_repo_revision": "production", 06:37:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:37:47 INFO - "repository": "", 06:37:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:37:47 INFO - "buildid": "20160601055046", 06:37:47 INFO - "pgo_build": "False", 06:37:47 INFO - "basedir": "/builds/slave/test", 06:37:47 INFO - "buildnumber": 3029, 06:37:47 INFO - "slavename": "talos-linux64-ix-001", 06:37:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:37:47 INFO - "platform": "ubuntu64_hw", 06:37:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:37:47 INFO - "branch": "fx-team", 06:37:47 INFO - "repo_path": "integration/fx-team", 06:37:47 INFO - "revision": "5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e", 06:37:47 INFO - "stage_platform": "linux64", 06:37:47 INFO - "builduid": "f1483944f64a4a3c8e2dce3f8263d3f6", 06:37:47 INFO - "slavebuilddir": "test" 06:37:47 INFO - } 06:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:37:47 INFO - Running post-action listener: _resource_record_post_action 06:37:47 INFO - ##### 06:37:47 INFO - ##### Finished read-buildbot-config step (success) 06:37:47 INFO - ##### 06:37:47 INFO - ##### 06:37:47 INFO - ##### Running download-and-extract step. 06:37:47 INFO - ##### 06:37:47 INFO - Running pre-action listener: _resource_record_pre_action 06:37:47 INFO - Running main action method: download_and_extract 06:37:47 INFO - mkdir: /builds/slave/test/build/tests 06:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:47 INFO - https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:37:47 INFO - Downloaded 1361 bytes. 06:37:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:37:47 INFO - Using the following test package requirements: 06:37:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:37:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:37:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'jsshell-linux-x86_64.zip'], 06:37:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:37:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:37:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:37:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:37:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:37:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:37:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:37:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:47 INFO - https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:49 INFO - Downloaded 22840449 bytes. 06:37:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:37:50 INFO - Return code: 0 06:37:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:37: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')]} 06:37:50 INFO - https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:37:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:37:51 INFO - Downloaded 22840449 bytes. 06:37:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:37:52 INFO - Return code: 0 06:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:37:52 INFO - https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:37:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:37:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:37:54 INFO - Downloaded 10834055 bytes. 06:37:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:37:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:37:54 INFO - Return code: 0 06:37: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')]} 06:37:54 INFO - https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:37:56 INFO - Downloaded 55033998 bytes. 06:37:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:56 INFO - mkdir: /builds/slave/test/properties 06:37:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:37:56 INFO - Writing to file /builds/slave/test/properties/build_url 06:37:56 INFO - Contents: 06:37:56 INFO - build_url:https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:37:57 INFO - Running post-action listener: _resource_record_post_action 06:37:57 INFO - Running post-action listener: set_extra_try_arguments 06:37:57 INFO - ##### 06:37:57 INFO - ##### Finished download-and-extract step (success) 06:37:57 INFO - ##### 06:37:57 INFO - ##### 06:37:57 INFO - ##### Running populate-webroot step. 06:37:57 INFO - ##### 06:37:57 INFO - Running pre-action listener: _resource_record_pre_action 06:37:57 INFO - Running main action method: populate_webroot 06:37:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:37:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:37:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:37:57 INFO - '--tppagecycles', 06:37:57 INFO - '7'], 06:37:57 INFO - 'tests': ['tsvgm']}}, 06:37:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:37:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:37:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:37:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:37:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:37:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['damp', 'tps']}, 06:37:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'tests': ['damp', 'tps']}, 06:37:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['dromaeo_dom']}, 06:37:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:37:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'other-e10s': {'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['a11yr', 06:37:57 INFO - 'ts_paint', 06:37:57 INFO - 'tpaint', 06:37:57 INFO - 'sessionrestore', 06:37:57 INFO - 'sessionrestore_no_auto_restore', 06:37:57 INFO - 'tabpaint']}, 06:37:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['tsvgx', 06:37:57 INFO - 'tsvgr_opacity', 06:37:57 INFO - 'tart', 06:37:57 INFO - 'tscrollx', 06:37:57 INFO - 'cart']}, 06:37:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:37:57 INFO - 'tsvgr_opacity', 06:37:57 INFO - 'tart', 06:37:57 INFO - 'tscrollx', 06:37:57 INFO - 'cart']}, 06:37:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'talos_options': ['--disable-e10s'], 06:37:57 INFO - 'tests': ['tp5o']}, 06:37:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'tests': ['tp5o']}, 06:37:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'talos_options': ['--disable-e10s', 06:37:57 INFO - '--xperf_path', 06:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:57 INFO - 'tests': ['tp5n']}, 06:37:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:37:57 INFO - 'talos_options': ['--xperf_path', 06:37:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:37:57 INFO - 'tests': ['tp5n']}}, 06:37:57 INFO - 'talos.zip': {'path': '', 06:37:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:37:57 INFO - Running post-action listener: _resource_record_post_action 06:37:57 INFO - ##### 06:37:57 INFO - ##### Finished populate-webroot step (success) 06:37:57 INFO - ##### 06:37:57 INFO - ##### 06:37:57 INFO - ##### Running create-virtualenv step. 06:37:57 INFO - ##### 06:37:57 INFO - Running pre-action listener: _resource_record_pre_action 06:37:57 INFO - Running main action method: create_virtualenv 06:37:57 INFO - Creating virtualenv /builds/slave/test/build/venv 06:37: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 06:37:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:37:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:37:57 INFO - Using real prefix '/usr' 06:37:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:37:58 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:00 INFO - Installing pip.................done. 06:38:00 INFO - Return code: 0 06:38:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38: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 06:38: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 06:38:00 INFO - Using env: {'DISPLAY': ':0', 06:38:00 INFO - 'HOME': '/home/cltbld', 06:38:00 INFO - 'LANG': 'en_US.UTF-8', 06:38:00 INFO - 'LANGUAGE': 'en_US:en', 06:38:00 INFO - 'LOGNAME': 'cltbld', 06:38:00 INFO - 'MAIL': '/var/mail/cltbld', 06:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:00 INFO - 'MOZ_NO_REMOTE': '1', 06:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:00 INFO - 'NO_EM_RESTART': '1', 06:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:00 INFO - 'PWD': '/builds/slave/test', 06:38:00 INFO - 'SHELL': '/bin/bash', 06:38:00 INFO - 'SHLVL': '1', 06:38:00 INFO - 'TERM': 'linux', 06:38:00 INFO - 'TMOUT': '86400', 06:38:00 INFO - 'USER': 'cltbld', 06:38:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:00 INFO - '_': '/tools/buildbot/bin/python'} 06:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38: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 06:38:00 INFO - Cleaning up... 06:38:00 INFO - Return code: 0 06:38:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38: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 06:38: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 06:38:00 INFO - Using env: {'DISPLAY': ':0', 06:38:00 INFO - 'HOME': '/home/cltbld', 06:38:00 INFO - 'LANG': 'en_US.UTF-8', 06:38:00 INFO - 'LANGUAGE': 'en_US:en', 06:38:00 INFO - 'LOGNAME': 'cltbld', 06:38:00 INFO - 'MAIL': '/var/mail/cltbld', 06:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:00 INFO - 'MOZ_NO_REMOTE': '1', 06:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:00 INFO - 'NO_EM_RESTART': '1', 06:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:00 INFO - 'PWD': '/builds/slave/test', 06:38:00 INFO - 'SHELL': '/bin/bash', 06:38:00 INFO - 'SHLVL': '1', 06:38:00 INFO - 'TERM': 'linux', 06:38:00 INFO - 'TMOUT': '86400', 06:38:00 INFO - 'USER': 'cltbld', 06:38:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:00 INFO - '_': '/tools/buildbot/bin/python'} 06:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:00 INFO - Downloading/unpacking psutil>=3.1.1 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:02 INFO - Installing collected packages: psutil 06:38:02 INFO - Running setup.py install for psutil 06:38:02 INFO - building 'psutil._psutil_linux' extension 06:38: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 06:38:02 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 06:38:02 INFO - building 'psutil._psutil_posix' extension 06:38:02 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 06:38: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 06:38:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:03 INFO - Successfully installed psutil 06:38:03 INFO - Cleaning up... 06:38:03 INFO - Return code: 0 06:38:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38: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 06:38: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 06:38:03 INFO - Using env: {'DISPLAY': ':0', 06:38:03 INFO - 'HOME': '/home/cltbld', 06:38:03 INFO - 'LANG': 'en_US.UTF-8', 06:38:03 INFO - 'LANGUAGE': 'en_US:en', 06:38:03 INFO - 'LOGNAME': 'cltbld', 06:38:03 INFO - 'MAIL': '/var/mail/cltbld', 06:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:03 INFO - 'MOZ_NO_REMOTE': '1', 06:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:03 INFO - 'NO_EM_RESTART': '1', 06:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:03 INFO - 'PWD': '/builds/slave/test', 06:38:03 INFO - 'SHELL': '/bin/bash', 06:38:03 INFO - 'SHLVL': '1', 06:38:03 INFO - 'TERM': 'linux', 06:38:03 INFO - 'TMOUT': '86400', 06:38:03 INFO - 'USER': 'cltbld', 06:38:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:03 INFO - '_': '/tools/buildbot/bin/python'} 06:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:38:05 INFO - Installing collected packages: mozsystemmonitor 06:38:05 INFO - Running setup.py install for mozsystemmonitor 06:38:05 INFO - Successfully installed mozsystemmonitor 06:38:05 INFO - Cleaning up... 06:38:05 INFO - Return code: 0 06:38:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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', '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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:38: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 blobuploader==1.2.4 06:38:05 INFO - Using env: {'DISPLAY': ':0', 06:38:05 INFO - 'HOME': '/home/cltbld', 06:38:05 INFO - 'LANG': 'en_US.UTF-8', 06:38:05 INFO - 'LANGUAGE': 'en_US:en', 06:38:05 INFO - 'LOGNAME': 'cltbld', 06:38:05 INFO - 'MAIL': '/var/mail/cltbld', 06:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:05 INFO - 'MOZ_NO_REMOTE': '1', 06:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:05 INFO - 'NO_EM_RESTART': '1', 06:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:05 INFO - 'PWD': '/builds/slave/test', 06:38:05 INFO - 'SHELL': '/bin/bash', 06:38:05 INFO - 'SHLVL': '1', 06:38:05 INFO - 'TERM': 'linux', 06:38:05 INFO - 'TMOUT': '86400', 06:38:05 INFO - 'USER': 'cltbld', 06:38:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:05 INFO - '_': '/tools/buildbot/bin/python'} 06:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:05 INFO - Downloading/unpacking blobuploader==1.2.4 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:07 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:08 INFO - Downloading docopt-0.6.1.tar.gz 06:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:08 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:08 INFO - Running setup.py install for blobuploader 06:38:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:08 INFO - Running setup.py install for requests 06:38:08 INFO - Running setup.py install for docopt 06:38:08 INFO - Successfully installed blobuploader requests docopt 06:38:08 INFO - Cleaning up... 06:38:08 INFO - Return code: 0 06:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:08 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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38:08 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 06:38:08 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 06:38:09 INFO - Using env: {'DISPLAY': ':0', 06:38:09 INFO - 'HOME': '/home/cltbld', 06:38:09 INFO - 'LANG': 'en_US.UTF-8', 06:38:09 INFO - 'LANGUAGE': 'en_US:en', 06:38:09 INFO - 'LOGNAME': 'cltbld', 06:38:09 INFO - 'MAIL': '/var/mail/cltbld', 06:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:09 INFO - 'MOZ_NO_REMOTE': '1', 06:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:09 INFO - 'NO_EM_RESTART': '1', 06:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:09 INFO - 'PWD': '/builds/slave/test', 06:38:09 INFO - 'SHELL': '/bin/bash', 06:38:09 INFO - 'SHLVL': '1', 06:38:09 INFO - 'TERM': 'linux', 06:38:09 INFO - 'TMOUT': '86400', 06:38:09 INFO - 'USER': 'cltbld', 06:38:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:09 INFO - '_': '/tools/buildbot/bin/python'} 06:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:09 INFO - Running setup.py (path:/tmp/pip-uMcrL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:09 INFO - Running setup.py (path:/tmp/pip-wf8qSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:09 INFO - Running setup.py (path:/tmp/pip-pBxebX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:09 INFO - Running setup.py (path:/tmp/pip-UXfw7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:09 INFO - Running setup.py (path:/tmp/pip-UCG3C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:09 INFO - Running setup.py (path:/tmp/pip-GdJtH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:09 INFO - Running setup.py (path:/tmp/pip-1kHwAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:09 INFO - Running setup.py (path:/tmp/pip-VhBWJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:09 INFO - Running setup.py (path:/tmp/pip-yZhY2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:09 INFO - Running setup.py (path:/tmp/pip-l6Awyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:09 INFO - Running setup.py (path:/tmp/pip-NsdPXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:09 INFO - Running setup.py (path:/tmp/pip-ur3b2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:10 INFO - Running setup.py (path:/tmp/pip-PUUijh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:10 INFO - Running setup.py (path:/tmp/pip-K_DcMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:10 INFO - Running setup.py (path:/tmp/pip-AYoqNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:10 INFO - Running setup.py (path:/tmp/pip-nkP2at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:10 INFO - Running setup.py (path:/tmp/pip-d95GTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:10 INFO - Running setup.py install for manifestparser 06:38:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:10 INFO - Running setup.py install for mozcrash 06:38:10 INFO - Running setup.py install for mozdebug 06:38:10 INFO - Running setup.py install for mozdevice 06:38:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:10 INFO - Running setup.py install for mozfile 06:38:10 INFO - Running setup.py install for mozhttpd 06:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozinfo 06:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozInstall 06:38:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozleak 06:38:11 INFO - Running setup.py install for mozlog 06:38:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for moznetwork 06:38:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozprocess 06:38:11 INFO - Running setup.py install for mozprofile 06:38:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozrunner 06:38:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:11 INFO - Running setup.py install for mozscreenshot 06:38:11 INFO - Running setup.py install for moztest 06:38:12 INFO - Running setup.py install for mozversion 06:38:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:12 INFO - Cleaning up... 06:38:12 INFO - Return code: 0 06:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:12 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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38:12 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 06:38:12 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 06:38:12 INFO - Using env: {'DISPLAY': ':0', 06:38:12 INFO - 'HOME': '/home/cltbld', 06:38:12 INFO - 'LANG': 'en_US.UTF-8', 06:38:12 INFO - 'LANGUAGE': 'en_US:en', 06:38:12 INFO - 'LOGNAME': 'cltbld', 06:38:12 INFO - 'MAIL': '/var/mail/cltbld', 06:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:12 INFO - 'MOZ_NO_REMOTE': '1', 06:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:12 INFO - 'NO_EM_RESTART': '1', 06:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:12 INFO - 'PWD': '/builds/slave/test', 06:38:12 INFO - 'SHELL': '/bin/bash', 06:38:12 INFO - 'SHLVL': '1', 06:38:12 INFO - 'TERM': 'linux', 06:38:12 INFO - 'TMOUT': '86400', 06:38:12 INFO - 'USER': 'cltbld', 06:38:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:12 INFO - '_': '/tools/buildbot/bin/python'} 06:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:12 INFO - Running setup.py (path:/tmp/pip-K0lFbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:12 INFO - Running setup.py (path:/tmp/pip-OwvHuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:12 INFO - Running setup.py (path:/tmp/pip-OuvQAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:12 INFO - Running setup.py (path:/tmp/pip-WSYm2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:12 INFO - Running setup.py (path:/tmp/pip-bSoyA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:12 INFO - Running setup.py (path:/tmp/pip-sCICLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:12 INFO - Running setup.py (path:/tmp/pip-tK_UXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:12 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)) 06:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:12 INFO - Running setup.py (path:/tmp/pip-XB1DSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:13 INFO - Running setup.py (path:/tmp/pip-wPiOvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:13 INFO - Running setup.py (path:/tmp/pip-yzqfx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:13 INFO - Running setup.py (path:/tmp/pip-cuIwSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:13 INFO - Running setup.py (path:/tmp/pip-yb7ZII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:13 INFO - Running setup.py (path:/tmp/pip-GRLpVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:13 INFO - Running setup.py (path:/tmp/pip-1OkjGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:13 INFO - Running setup.py (path:/tmp/pip-x18pId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:13 INFO - Running setup.py (path:/tmp/pip-U6GTWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:13 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)) 06:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:13 INFO - Running setup.py (path:/tmp/pip-2kMmJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:13 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)) 06:38:13 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)) 06:38:13 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)) 06:38:13 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)) 06:38:13 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)) 06:38:13 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)) 06:38:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:13 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 06:38:13 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 06:38:13 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 06:38:13 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 06:38:13 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 06:38:13 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 06:38:15 INFO - Downloading blessings-1.6.tar.gz 06:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:15 INFO - Installing collected packages: blessings 06:38:15 INFO - Running setup.py install for blessings 06:38:15 INFO - Successfully installed blessings 06:38:15 INFO - Cleaning up... 06:38:15 INFO - Return code: 0 06:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:16 INFO - Reading from file tmpfile_stdout 06:38:16 INFO - Current package versions: 06:38:16 INFO - argparse == 1.2.1 06:38:16 INFO - blessings == 1.6 06:38:16 INFO - blobuploader == 1.2.4 06:38:16 INFO - docopt == 0.6.1 06:38:16 INFO - manifestparser == 1.1 06:38:16 INFO - mozInstall == 1.12 06:38:16 INFO - mozcrash == 0.17 06:38:16 INFO - mozdebug == 0.1 06:38:16 INFO - mozdevice == 0.48 06:38:16 INFO - mozfile == 1.2 06:38:16 INFO - mozhttpd == 0.7 06:38:16 INFO - mozinfo == 0.9 06:38:16 INFO - mozleak == 0.1 06:38:16 INFO - mozlog == 3.2 06:38:16 INFO - moznetwork == 0.27 06:38:16 INFO - mozprocess == 0.22 06:38:16 INFO - mozprofile == 0.28 06:38:16 INFO - mozrunner == 6.11 06:38:16 INFO - mozscreenshot == 0.1 06:38:16 INFO - mozsystemmonitor == 0.3 06:38:16 INFO - moztest == 0.7 06:38:16 INFO - mozversion == 1.4 06:38:16 INFO - psutil == 3.1.1 06:38:16 INFO - requests == 1.2.3 06:38:16 INFO - wsgiref == 0.1.2 06:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:16 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')]} 06:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:16 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')]} 06:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:16 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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38:16 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 06:38:16 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 06:38:16 INFO - Using env: {'DISPLAY': ':0', 06:38:16 INFO - 'HOME': '/home/cltbld', 06:38:16 INFO - 'LANG': 'en_US.UTF-8', 06:38:16 INFO - 'LANGUAGE': 'en_US:en', 06:38:16 INFO - 'LOGNAME': 'cltbld', 06:38:16 INFO - 'MAIL': '/var/mail/cltbld', 06:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:16 INFO - 'MOZ_NO_REMOTE': '1', 06:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:16 INFO - 'NO_EM_RESTART': '1', 06:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:16 INFO - 'PWD': '/builds/slave/test', 06:38:16 INFO - 'SHELL': '/bin/bash', 06:38:16 INFO - 'SHLVL': '1', 06:38:16 INFO - 'TERM': 'linux', 06:38:16 INFO - 'TMOUT': '86400', 06:38:16 INFO - 'USER': 'cltbld', 06:38:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:16 INFO - '_': '/tools/buildbot/bin/python'} 06:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 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)) 06:38:16 INFO - Cleaning up... 06:38:16 INFO - Return code: 0 06:38:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:38:16 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')]} 06:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:16 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')]} 06:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:16 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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38:16 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 06:38:16 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 06:38:16 INFO - Using env: {'DISPLAY': ':0', 06:38:16 INFO - 'HOME': '/home/cltbld', 06:38:16 INFO - 'LANG': 'en_US.UTF-8', 06:38:16 INFO - 'LANGUAGE': 'en_US:en', 06:38:16 INFO - 'LOGNAME': 'cltbld', 06:38:16 INFO - 'MAIL': '/var/mail/cltbld', 06:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:16 INFO - 'MOZ_NO_REMOTE': '1', 06:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:16 INFO - 'NO_EM_RESTART': '1', 06:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:16 INFO - 'PWD': '/builds/slave/test', 06:38:16 INFO - 'SHELL': '/bin/bash', 06:38:16 INFO - 'SHLVL': '1', 06:38:16 INFO - 'TERM': 'linux', 06:38:16 INFO - 'TMOUT': '86400', 06:38:16 INFO - 'USER': 'cltbld', 06:38:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:16 INFO - '_': '/tools/buildbot/bin/python'} 06:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:16 INFO - Downloading/unpacking jsonschema 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:18 INFO - Downloading/unpacking functools32 (from jsonschema) 06:38:18 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 06:38:18 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 06:38:18 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 06:38:18 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 06:38:18 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 06:38:18 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 06:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:18 INFO - warning: no files found matching '*.txt' 06:38:18 INFO - no previously-included directories found matching 'build' 06:38:18 INFO - no previously-included directories found matching 'dist' 06:38:18 INFO - no previously-included directories found matching '.git*' 06:38:18 INFO - Installing collected packages: jsonschema, functools32 06:38:18 INFO - Running setup.py install for functools32 06:38:18 INFO - warning: no files found matching '*.txt' 06:38:18 INFO - no previously-included directories found matching 'build' 06:38:18 INFO - no previously-included directories found matching 'dist' 06:38:18 INFO - no previously-included directories found matching '.git*' 06:38:18 INFO - Successfully installed jsonschema functools32 06:38:18 INFO - Cleaning up... 06:38:18 INFO - Return code: 0 06:38:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:38: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')]} 06:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:18 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 0x7f208c968f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, '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': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', '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 06:38:18 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 06:38:18 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 06:38:18 INFO - Using env: {'DISPLAY': ':0', 06:38:18 INFO - 'HOME': '/home/cltbld', 06:38:18 INFO - 'LANG': 'en_US.UTF-8', 06:38:18 INFO - 'LANGUAGE': 'en_US:en', 06:38:18 INFO - 'LOGNAME': 'cltbld', 06:38:18 INFO - 'MAIL': '/var/mail/cltbld', 06:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:18 INFO - 'MOZ_NO_REMOTE': '1', 06:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:18 INFO - 'NO_EM_RESTART': '1', 06:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:18 INFO - 'PWD': '/builds/slave/test', 06:38:18 INFO - 'SHELL': '/bin/bash', 06:38:18 INFO - 'SHLVL': '1', 06:38:18 INFO - 'TERM': 'linux', 06:38:18 INFO - 'TMOUT': '86400', 06:38:18 INFO - 'USER': 'cltbld', 06:38:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:18 INFO - '_': '/tools/buildbot/bin/python'} 06:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:19 INFO - Downloading/unpacking flake8 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:38:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:38:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:21 INFO - no previously-included directories found matching 'docs/_build' 06:38:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:38:21 INFO - Running setup.py install for pep8 06:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:21 INFO - no previously-included directories found matching 'docs/_build' 06:38:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:38:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:38:21 INFO - Cleaning up... 06:38:22 INFO - Return code: 0 06:38:22 INFO - Running post-action listener: _resource_record_post_action 06:38:22 INFO - Running post-action listener: _start_resource_monitoring 06:38:22 INFO - Starting resource monitoring. 06:38:22 INFO - ##### 06:38:22 INFO - ##### Finished create-virtualenv step (success) 06:38:22 INFO - ##### 06:38:22 INFO - ##### 06:38:22 INFO - ##### Running install step. 06:38:22 INFO - ##### 06:38:22 INFO - Running pre-action listener: _resource_record_pre_action 06:38:22 INFO - Running main action method: install 06:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:38:22 INFO - Reading from file tmpfile_stdout 06:38:22 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:38:22 INFO - Reading from file tmpfile_stdout 06:38:22 INFO - Output received: 06:38:22 INFO - Usage: mozinstall [options] installer 06:38:22 INFO - Options: 06:38:22 INFO - -h, --help show this help message and exit 06:38:22 INFO - -d DEST, --destination=DEST 06:38:22 INFO - Directory to install application into. [default: 06:38:22 INFO - "/builds/slave/test"] 06:38:22 INFO - --app=APP Application being installed. [default: firefox] 06:38:22 INFO - mkdir: /builds/slave/test/build/application 06:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:38:38 INFO - Reading from file tmpfile_stdout 06:38:38 INFO - Output received: 06:38:38 INFO - /builds/slave/test/build/application/firefox/firefox 06:38:38 INFO - Running post-action listener: _resource_record_post_action 06:38:38 INFO - ##### 06:38:38 INFO - ##### Finished install step (success) 06:38:38 INFO - ##### 06:38:38 INFO - ##### 06:38:38 INFO - ##### Running run-tests step. 06:38:38 INFO - ##### 06:38:38 INFO - Running pre-action listener: _resource_record_pre_action 06:38:38 INFO - Running main action method: run_tests 06:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:38:38 INFO - Python 2.7.3 06:38:38 INFO - Return code: 0 06:38:38 INFO - grabbing minidump binary from tooltool 06:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:38 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 0x1c9a9c0>, '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 0x1c9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c9bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:38:38 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 06:38:38 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 06:38:38 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 06:38:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:38:38 INFO - Return code: 0 06:38:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:38:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:38:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:38:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:38:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:38:39 INFO - Return code: 0 06:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:38:39 INFO - Using env: {'DISPLAY': ':0', 06:38:39 INFO - 'HOME': '/home/cltbld', 06:38:39 INFO - 'LANG': 'en_US.UTF-8', 06:38:39 INFO - 'LANGUAGE': 'en_US:en', 06:38:39 INFO - 'LOGNAME': 'cltbld', 06:38:39 INFO - 'MAIL': '/var/mail/cltbld', 06:38:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:38:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:39 INFO - 'MOZ_NO_REMOTE': '1', 06:38:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:39 INFO - 'NO_EM_RESTART': '1', 06:38:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:39 INFO - 'PWD': '/builds/slave/test', 06:38:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:38:39 INFO - 'SHELL': '/bin/bash', 06:38:39 INFO - 'SHLVL': '1', 06:38:39 INFO - 'TERM': 'linux', 06:38:39 INFO - 'TMOUT': '86400', 06:38:39 INFO - 'USER': 'cltbld', 06:38:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433', 06:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:39 INFO - '_': '/tools/buildbot/bin/python'} 06:38:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:38:39 INFO - mozversion application_buildid: 20160601055046 06:38:39 INFO - mozversion application_changeset: 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e 06:38:39 INFO - mozversion application_display_name: Nightly 06:38:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:38:39 INFO - mozversion application_name: Firefox 06:38:39 INFO - mozversion application_remotingname: firefox 06:38:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:38:39 INFO - mozversion application_vendor: Mozilla 06:38:39 INFO - mozversion application_version: 49.0a1 06:38:39 INFO - mozversion platform_buildid: 20160601055046 06:38:39 INFO - mozversion platform_changeset: 5ca8ea4f429a8415335cccbf3c00a57ffd0ca93e 06:38:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:38:39 INFO - mozversion platform_version: 49.0a1 06:38:39 INFO - using testdate: 1464788319 06:38:39 INFO - actual date: 1464788319 06:38:39 INFO - starting webserver on 'localhost:38528' 06:38:39 INFO - SUITE-START | Running 2 tests 06:38:39 INFO - TEST-START | dromaeo_css 06:38:39 INFO - operating with platform_type : linux_ 06:38:39 INFO - Initialising browser for dromaeo_css test... 06:38:39 INFO - TEST-INFO | started process 17963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DpUpe/profile http://localhost:38528/getInfo.html) 06:38:43 INFO - PROCESS | 17963 | __metrics Screen width/height:1600/1200 06:38:43 INFO - PROCESS | 17963 | colorDepth:24 06:38:43 INFO - PROCESS | 17963 | Browser inner width/height: 1024/697 06:38:43 INFO - PROCESS | 17963 | __metrics 06:38:44 ERROR - PROCESS | 17963 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:38:45 INFO - TEST-INFO | 17963: exit 0 06:38:45 INFO - Browser initialized. 06:38:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:38:45 INFO - TEST-INFO | started process 18045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DpUpe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:57 INFO - PROCESS | 18045 | RSS: Main: 157495296 06:38:57 INFO - PROCESS | 18045 | 06:39:49 INFO - PROCESS | 18045 | 1464788389327 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] 06:42:00 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38528/tests/dromaeo/cssquery-ext.html) 06:42:02 INFO - PROCESS | 18045 | RSS: Main: 271118336 06:42:02 INFO - PROCESS | 18045 | 06:45:04 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-ext.html (next: http://localhost:38528/tests/dromaeo/cssquery-jquery.html) 06:45:05 INFO - PROCESS | 18045 | RSS: Main: 241430528 06:45:05 INFO - PROCESS | 18045 | 06:48:07 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38528/tests/dromaeo/cssquery-mootools.html) 06:48:08 INFO - PROCESS | 18045 | RSS: Main: 233369600 06:48:08 INFO - PROCESS | 18045 | 06:51:10 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38528/tests/dromaeo/cssquery-prototype.html) 06:51:10 INFO - PROCESS | 18045 | RSS: Main: 239247360 06:51:10 INFO - PROCESS | 18045 | 06:54:13 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38528/tests/dromaeo/cssquery-yui.html) 06:54:14 INFO - PROCESS | 18045 | RSS: Main: 219312128 06:54:14 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | Cycle 1(1): loaded http://localhost:38528/tests/dromaeo/cssquery-yui.html (next: http://localhost:38528/tests/dromaeo/cssquery-dojo.html) 06:57:17 INFO - PROCESS | 18045 | RSS: Main: 312909824 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | __start_tp_report 06:57:17 INFO - PROCESS | 18045 | _x_x_mozilla_page_load 06:57:17 INFO - PROCESS | 18045 | _x_x_mozilla_page_load_details 06:57:17 INFO - PROCESS | 18045 | |i|pagename|runs| 06:57:17 INFO - PROCESS | 18045 | |0;dojo.html;2638.155790147153;2686.0196028449595;2717.8505182214976;2738.014314846655;2738.8219765715226;4515.412996310475;4595.080983803236;4641.3038044293335;4753.3820603321565;4800.135975524404;4588.059447813199;4626.375439315691;4645.605123564493;4661.510541393156;4666.23007203811;4276.828926842938;4285.035866929947;4297.097609502009;4312.439382880221;4428.6014258716705;4358.455193100863;4401.295792673173;4406.647468202536;4439.977800110995;4450.310201918708;4190.706650534464;4356.695031347807;4382.824687012516;4398.010447649253;4403.471583409995;4211.199872024336;4249.723767955073;4252.87241382759;4272.786360681954;4315.115401342718;4212.073343864345;4272.01743598974;4287.378330142144;4289.6997210195295;4325.199838029975;4454.643628509712;4619.5611416915335;4638.420197475316;4641.025384669224;4642.164410406125;4978.452370239271;4996.100701873697;5051.848444546669;5118.488151184889;5126.384833819928;5117.7185254810975;5120.641555091145;5130.050940576006;5133.153029750087;5150.072986862363;4577.244754615518;4613.123506533748;4630.72215667061;4646.070785842845;4664.230401983703;5108.591312694975;5145.382554093533;5146.588272938156;5177.430482646906;5202.60980426462;4930.482299358588;4933.9013219736125;4966.056449274626;4975.90048199034;4982.302477653131;4869.9269510957365;4954.058728841508;4995.125852975787;5068.341115654941;5069.949300507022;4967.230079337708;4989.55094041538;4994.126027945095;4994.9500504994485;5016.423111342242;4953.133201689762;4960.007998400334;4960.330355401975;4963.205887058053;4992.600591952708;3995.841206050271;4020.597940205956;4135.524414692289;4149.232392007489;4191.434156388848;3653.9817300913855;3668.3194660645977;3673.081729567608;3705.9814700926863;3715.108373990223;4332.1985432695055;4332.458442694663;4335.176316499918;4359.869203923888;4378.408914796525;4869.902601947942;4957.628177886673;4986.476419975923;4999.475055119233;5051.1413059779925;4278.486581610165;4302.913941721211;4340.891477713082;4349.021470169187;4350.129974005148;4383.342498625232;4385.188740083095;4420.557944205618;4427.114577084596;4430.955690443055;4620.330052142488;4735.289706544046;4780.450248221499;4791.233402655558;4797.928031079537;5050.9747451263975;5053.797848086036;5080.923786143285;5098.056859481007;5140.100482415488;4839.879003024953;4867.123917694849;4872.366592342973;4874.147024270809;4903.26451032348;4778.761061946958;4948.282499037691;4962.702237865739;4984.22744474607;5060.139776237975;5068.518490743373;5079.441261461162;5089.923651145162;5095.490450954875;5138.3577052868395;4920.212765957573;4936.136176169228;4937.1113199624415;4938.012397520439;4989.675671081368;4748.074125545486;4864.464908859952;4879.170541008109;4912.6561140719805;4929.827456039022;4835.347228124158;4864.464908859952;4894.877628059327;4907.926381104215;4909.582685471775;4833.95166048335;4976.477469865612;4980.551750342342;5029.572486338556;5032.421271553818;4782.043591281688;4798.1123492154065;4838.806447742191;4865.367502224688;4909.386326709161 06:57:17 INFO - PROCESS | 18045 | |1;ext.html;546.218906963043;594.6224147666233;595.0924839619577;595.1073389915127;605.3583201806086;27611.447771044568;39806.800965995164;40413;40429.79785101078;40529.59470405295;41246.58753412465;41654;41689.7915510422;41738.373924391155;41810.37284440736;7382.446316526255;7634.35108015818;7832.373410127205;7836.0596728392675;9934.552945117486;9790.70627881161;10251.487425628726;10253.282270241049;10259.538320775582;10263.743406414826;10127.29108962373;10228.89771102287;10231.948840255789;10235.795284094314;10235.897641023606;7500;7735.690572377154;7735.9613201933635;9920.603175872957;10163.59345626174;9805.411675299434;10187.643432479828;10191.541380637815;10192.490375481197;10203.540840662114;38682.41976370357;39281.60718392837;39323.41014884779;39357.21285574301;39401.80299098515;3085.2595377109556;3143.795653282529;3332.500124981248;3372.5952885653633;3735.6637902588627;29383;29456.263593410124;29609.40781184386;29704.70295297041;30314.69685303163;3279.967200328014;3506.2461570762407;3533.3463309287863;3553.502509648651;3592.4431713084255;280158;281588;283099;283281.99999999796;283460;31914.52128218032;55763;56639;56648.43351566514;56698.43301567014;32562;34652.30695386128;34661;34674.133146671535;34703.652963470544;13116.672083197805;13295.468181272834;13304.667383315495;13308.866911330957;13315.467381304834;9720.708378748508;10518.947405263078;10766.838497422545;10769.83845242322;10994.240921452689;7957.6021198939825;7960.641771120314;7977.720779772796;8048.074471435742;8048.798780030546;3128.9374212515622;3141.1989942564956;3169.128489665314;3184.8885289014775;3216.32457183994;880.4849163239577;935.6678379175431;1017.7404761785697;1047.1047254597363;1049.6850944716555;28886.711132888402;29040.7095929038;29146;29525.557116643267;29579.704202957695;959.7984423271191;967.4823969176598;988.9703308900745;997.6358629100326;1028.943408112561;15024.399024039134;15031.323590438456;15279.541613751606;15317.46388876384;15441.922790386201;419687;420878;421680;422154;422889;48607.51392486101;49651.25523117156;49869.50130498649;49873.50126498689;49895.25157122646;1090.8527348807968;1201.3092471828734;1211.7697637449032;1241.7578572178338;1241.937903104841;28241.57637635396;28944.276393090342;29190.41619167647;29751.55372669455;29905.401891962472;41887.162256755306;42159.36760948527;42292.78853605712;42351;42354.78822605867;291425;295862;295884;296041;296733;22493.100275988778;23122.653160202946;24680.13619523308;25503.872480637478;25581;42019.1596168081;42086.78956605197;42292;42851.14297714091;43164.19432736862;36156;36382.27235455223;37320.62679373172;37772.43341349827;38543.80728096454;37032.814835925645;37637.78116318675;37866.432003520524;37948.24103517969;38001.61998379981;35593;36091.63908360988;36686.449703255006;36829.26341473102;36933.076673082316;30191;34421.82789086038;34652.48021279733;34669.65330346664;34801.12997175091;25841.68061349357;26057.869710651325;26122.738772612032;26268.21195364142;26471.073512426974 06:57:17 INFO - PROCESS | 18045 | |2;jquery.html;364.8412940370938;369.6211383332084;369.8834867016889;382.3022983055924;383.3808399434912;16262;16796;16882.66234675306;17055.82944170558;17257.82742172578;15886.52340429786;16208.270627821747;16815.15924203788;16863.747043794323;16886.324547018103;4884.023195360925;4953.9504604953845;4960.131976904046;5153.56194723449;5153.6392452528335;3704.425813998821;3892.5328960524635;5020.146575082244;5531.944680553183;5842.912356314638;5869.7652093916195;5881.088431293135;5917.674527900964;5920.585559010871;5921.052631578948;5781.4507621775865;5820.941790582104;5908.67502287374;5930.673812940287;5939.5248380129915;3348.514465402503;4907.656464047483;5173.405058418292;5220.660657057317;5222.451642577513;19505.707414388795;20187.293444729363;20204.29284975019;20205;20264.79735202644;1787.9642407151784;1846.778386593604;2180.160638154306;2430.829841911067;2443.6701045358827;12532.185407948546;12778.297193654345;12857.4214160363;12947.805782913263;13389.464421423132;1546.1109861829493;1549.1170033081148;1550.6821101674243;1571.363597742916;1636;57837.42162578362;59735;61055.69472152655;67503;69205.65397172981;9873.716416865762;9900.653477128266;10080.697579072494;10111.949440252753;10254.692359229235;13920.651983700489;14001.649958751113;14003.159810411204;14018.859811401959;14043.157410555195;6979.581225126407;7020.087388639444;7125.964370178116;7145.535540189871;7199.856002879913;6460.095586617877;6546.443552298013;6621.702023408958;6700.597964122071;6711.899321510181;4282.293421585404;4293.763842988666;4339.7396156230725;4374.956250437519;4419.867403977886;1668.9569019362898;1686.6879627268995;1783.3428191993835;1830.229101736265;1845.1512304340154;880.3705350674298;900.7432881628836;957.1959553974694;965.7295957132014;966.3766870368713;15805.209739512979;16132.919335403249;16400.507984760476;16978.320867165174;17033.574160646083;801.9719309824128;886.8625363068735;913.7715571107224;921.829461549602;938.6433155400904;9072.319576031825;9141.81716365669;9444.905550944402;9570.56932438042;9615.56729947154;370176;377777;378170.41892277467;378498;379001;67622.32377676258;68808;69341.3065869345;69656;70743.6462817693;851.5188918261039;909.0818273543769;924.8057907839294;948.0850978805486;953.7043516509904;14625.92687036558;14652.560423187322;14665.343037728226;14678.779818302948;15112.697746045238;27466.725332747217;30104.698953011066;31593;33364.49953250655;35383.11542211465;43555;47024;47097.76451117722;47115.528844712484;47647.28529072136;7019.5788252705;7174.139103307636;7218.566885986857;7242.637868106679;7338;7952.602369881367;9405.858912116188;10511.526981285708;10581.947090264499;10711.464426778473;8923.15230053144;8963.641454342014;9247.39891907024;9289.62841486333;9450.905490945277;9281.67514137002;9352.625894964125;9583.520823958635;9713.611455541699;9840.557174927002;8895.555222238732;9069.77325566866;9495;9581.473018984023;9681.467519286507;6788.93211067883;7056.188538317954;7181.174164971095;7181.964090179516;7402.9629851850395;8372.958135209285;9191.942926563263;9463.621455141718;9570.234381249622;9639.662611808553 06:57:17 INFO - PROCESS | 18045 | |3;mootools.html;1225.9754804903896;1403.8455769865313;1440.200688617817;1549.7985261915956;1777.2535535075276;6889.069975553299;7750.92249077509;7966.800829979254;7978.401619878503;8213;7926.92073079269;8107.35141188705;8118.228768267005;8135.511869287847;8140.348772098233;2160.243914629875;2192.210804110527;2200.3179014505477;2200.515886504966;2201.218567408571;2167.295628920607;2203.3059586230365;2230.520438105807;2230.8661480311152;2232.598132336179;2197.6154173019736;2209.4034610655112;2218.689383486313;2224.7663995280504;2233.3076746208726;2156.0156909479183;2176.053416763713;2181.1820567287186;2184.683220932956;2188.6388745856993;2156.8813715245656;2169.9240526581493;2171.174953517653;2171.576542574199;2178.6078505868936;7810.765677029642;7843.568603726792;7879.487833290817;7967.840643187162;8234.094249632535;4668.183067963093;4755.334253204554;4790.904181916342;4793.496682848286;4803.927941080887;2832.5751137329357;2904.4481548505714;2949.0120809528835;2965.747911427531;2970.628671416073;865.2169786343369;893.6461261189304;900.4507250577143;907.6823111910778;908.7228395339419;11077.723056923562;11230.719232019183;11231.775364492665;11233.66299011031;11251.83122253167;4088.100617864065;4172.436721042681;4173.269677806372;4224.197402493516;4300.333448315516;8749.65001399937;8824.691135810215;8836;8848.867266991001;8849.247813935759;4586.678932474695;4655.2784318430695;4663.556962088596;4664.626829853603;4671.48613652498;3794.4877441545036;3850.825498223013;3863.9613603864163;4201.915961680749;4253.744775313491;3390.677885600864;3514.367413865478;3524.3656141894194;3569.660882216185;3569.910752231163;1001.8547310639916;1016.517154351677;1022.9386236825666;1031.6131450705984;1033.844923261517;844.396256676467;859.6389516403126;892.5849479991834;917.0050495212769;918.4397517514311;5592.105263157875;5602.439756024365;5756.194132821408;5817.069268916953;5869.266341707286;840.1766269056237;869.2090197919863;874.6282829797311;881.6781874615847;920.5719340506563;3810.904727381838;3823.9426408603895;3937.251922134785;3960.2277555876904;4001.4397984282223;9794.363366381162;10132.088112069801;10211.489425528842;10211.846822297672;10227.795444091076;9881.752956176153;10125;10140.442275674908;10197.74505637365;10210.846837297446;7529.134149572759;7574.469787114849;7595.734149304748;7639.503432276884;7675.923240767633;5611.57913156523;5685.147227915681;5697.145428185805;5709.857253568694;5853;9167.312451566026;9250.444973301623;9374.109459601326;9388.624455021996;9417.152456278967;9097.13577210164;9397.671081512115;9410.764730881509;9524.619015239312;9578.952105239709;5842.444967728059;6495.707693153914;6514.804555863332;6666.699998500176;6671.366220209073;7803.843923121619;7825.686972521035;7889.960550197212;7926.048874135141;7937.126916039116;6908.723651053901;7027.7188912442925;7070.893936591058;7178.928210717826;7181.533200341961;6855.931440685728;6990.196127445409;7004.894926576208;7076;7122.821929451805;6578.079068930258;6727.159105111861;6727.663616819042;6732.831679208059;6744.393004629607;5032.773525191448;5043.798248070036;5104.846854594368;5113.590912727047;5132.178851383761;5071.315372424823;5093.592512598909;5097.92353114711;5167.922481162861;5235.764390602356 06:57:17 INFO - PROCESS | 18045 | |4;prototype.html;292.8901661876796;303.5810581397671;304.6496528991661;309.9364630250799;310.08215681582516;4600.90798184037;4758.714477131366;4811.903761924759;4827.961988172542;4865.732384718839;4656.44122705275;4799.472058073609;4810.39870016248;4810.412563853929;4822.565969062784;3803.8098095095274;3818.9618103818952;3820.77075375477;3830.578636349999;3843.615638436162;3611.313850368435;3633.890983270493;3802.8478860845535;3811.8284677189454;3824.694024478035;3753.7184711146638;3766.435034744783;3786.8863934081883;3788.299164654548;3799.905002374935;3758.586555478895;3766.924661506782;3779.9433008504893;3780.319542482352;3781.2626537825136;3351.6480769519094;3368.2253081791323;3368.79787212768;3385.6445073267446;3385.796852188852;4546;4602.412167802103;4603.296780191351;4620.907581848344;4658.324542941288;4317.740935543878;4324.243257429937;4339.7830108494445;4341.696081274312;4360.694751367406;5005.873678422362;5009.34691551787;5015.348004759395;5028.41604894457;5055.570276526463;3571.2679799953057;3635.745497815154;3658.646300868669;3712.1462063725226;3715.1826598148364;5294.92057619136;5307.203919412081;5319.17552779316;5321.920171197435;5328.254044433782;3795.848166073326;3801.5248093988253;3804.4293355996824;3804.885853424402;3812.5615554211067;3692.9261414771554;3863.632954869283;3864.439656249828;3876.534815822063;3902.1220225449047;4300.333448315516;4308.784560771949;4309.224339618836;4317.633001194934;4331.5884990925815;4760.476347601761;5012.223105418666;5021.874453138701;5035.1873325602755;5044.798208071709;1279.3986826191674;1298.2794549025193;1303.1529505821293;1312.5602923020704;1323.6889331007205;834.3241974001079;848.8710015679131;861.7587075618836;865.3596338709435;870.5647176411794;3964.4053391991433;3978.8806335809973;3978.8806335809973;3980.8407663693706;4012.294774720732;4605.631549476034;4605.746683932416;4616.492185859553;4618.838340658061;4621.976890115528;3967.8412863485714;3972.7020473464604;3977.7525697981127;3987.4218238355274;3998.6801055915457;2358.6933698619414;2444.841085329448;2456.557819592455;2467.580511313081;2468.790152837029;4389.517153113219;4405.31717583775;4407.647388208936;4431.933520997188;4439.267520859086;4645.907081858344;4696.483386827515;4714.905701886011;4723.220668589713;4732.834350797705;4174.707770456039;4361.847335343247;4418.1222980233915;4490.259107247398;4493.842715504941;4645.23481077202;4659.860204193879;4696.38946936896;4704.67067305299;4720.409948756405;4502.7523486207265;4521.299198624219;4530.728156310632;4559.674565971312;4583.518730533246;4396.494403143552;4432.246518091868;4474.910501790011;4640.280756482751;5053.444121146745;3695.981520092382;3697.186618943828;3712.424574191005;3718.5537735470834;3718.7396882217986;5017.874553136201;5264.52619264268;5269.947300526946;5280.683159010472;5285.920711189412;4927.236278376858;5083.161278389024;5085.4914508548845;5097.92353114711;5125.410577783603;5063.8480845574695;5066.214736715815;5073.822416215415;5092.210707340369;5114.872128196825;4835.567778159683;5019.698818070928;5028.899422011613;5035.949640503548;5060.974695126648;5123.487651234846;5132.666376685504;5149.613778966517;5150.871228219325;5160.845174644766;5018.422881368543;5033.672811267403;5038.949610503848;5043.87390315245;5043.949560504348 06:57:17 INFO - PROCESS | 18045 | |5;yui.html;644.2687549631169;647.9222493300805;650.5381179362649;711.7153138744504;729.4164668265388;12032.33822139782;12539;13489.59531214064;13984.37070331835;14077.225752583603;13895.374708138133;13953.860461395383;13968;14007.0195086344;14023.789643155334;618.7834258009706;777.8755399136139;810.3112354498688;815.0097631377874;816.510093943635;812.378530424223;819.0417211862106;819.6516480495766;820.1634332980357;821.2362502872327;850.5619605902965;854.5257382152903;861.0270394454258;861.1130535548396;861.7156338408311;657.2507341630545;825.3520986025941;853.9103394143588;858.0175698824874;858.3476557816042;622.5299898576591;626.4362074133271;626.8056902360237;627.4635186915167;627.5230824573312;12667.429965651569;12763.617091487271;12785.488580456771;12788.360581970957;12813.807792883114;11436.142289328334;11769.764604707858;11919.582814601446;11958.701032474171;12081;10874.401907895062;10996.395198264092;11126.833097503462;11306.886931130748;11400.315981041163;4085.428040074392;4101.179764047172;4162.458880345535;4181.372794080882;4189.72766770162;43807.561924380665;44006.55993440057;46382;46915.53084469146;47789;9652.613895444245;9777.168940639984;9788.657396991071;9855.55649995752;9870.851937220947;17482.56293592645;17487.387941422243;17514;17520.29918803259;17531.56171095733;6724.4284235840505;6796.048553202556;6830.795076147723;6929.965350173217;7009.1589009319205;3667.1748856507606;3671.1372827385544;3742.8877133686033;3773.698104151716;3845.942310865339;2834.489791837489;2919.737223649839;2941.2205765472168;2942.7204415580914;2943.0876428307292;532.8108521474899;540.1533916261282;545.8389775016379;548.2543740512899;551.8647931256787;430.5608279554899;542.7150745858456;586.4783606297909;608.6165715599144;608.9421504957022;8194.180581941759;8436.789080273042;8442.409031367746;8549;8626.78433039179;575.9107338362561;603.5533705058313;606.0182504342905;607.1348328631682;613.4111253196892;3818.4463252828186;3849.9037524061564;3864.4589757433982;3881.4753172645273;3901.6098390160755;53084.20373694398;55529;56233.43766562282;56274.43725562692;56353;47780.52219477761;48298.517014830104;49619.50380496149;50772.23841642378;51066.48933510692;43481.347779783326;44830.55169448264;45559.31661025087;46020;46690;8284.834303313779;8441.493510389397;8673.392862499564;8808.163224493663;9141.725748227564;29985.700142999165;30479.238019048815;31020.379592408477;31230.063098107094;31684.5247321295;37320.62679373172;39942.40086398764;40052.599474004885;40369.1926161481;40643;11047.668569942593;11053.557857685924;11383.260088094248;11387.089032877515;11554.133439991867;11416.257943233995;11614.419279035845;11786;11823.76352472963;11951.282923024646;10912.181586381212;11143.164262680493;11393.715157120807;11537.365444900612;11542.653720388402;10817.945910270399;10972.835407469054;11102.61140860066;11172.441377931233;11190.66428007161;10999.34003959765;11244.26912250701;11550.191486595857;11653.76692466129;11657.591984280509;9376.67181648639;9484;9675.612975480903;9695.418274903528;9902.752431189278;9372.1565059145;10000.69997900035;10020.24848136378;10076;10123.7469063274 06:57:17 INFO - PROCESS | 18045 | __end_tp_report 06:57:17 INFO - PROCESS | 18045 | __start_cc_report 06:57:17 INFO - PROCESS | 18045 | _x_x_mozilla_cycle_collect,1031 06:57:17 INFO - PROCESS | 18045 | __end_cc_report 06:57:17 INFO - PROCESS | 18045 | __startTimestamp1464789437478__endTimestamp 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | ------- Summary: start ------- 06:57:17 INFO - PROCESS | 18045 | Number of tests: 6 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#0] dojo.html Cycles:165 Average:4641.59 Median:4798.11 stddev:492.51 (10.3%) stddev-sans-first:468.27 06:57:17 INFO - PROCESS | 18045 | Values: 2638.2 2686.0 2717.9 2738.0 2738.8 4515.4 4595.1 4641.3 4753.4 4800.1 4588.1 4626.4 4645.6 4661.5 4666.2 4276.8 4285.0 4297.1 4312.4 4428.6 4358.5 4401.3 4406.6 4440.0 4450.3 4190.7 4356.7 4382.8 4398.0 4403.5 4211.2 4249.7 4252.9 4272.8 4315.1 4212.1 4272.0 4287.4 4289.7 4325.2 4454.6 4619.6 4638.4 4641.0 4642.2 4978.5 4996.1 5051.8 5118.5 5126.4 5117.7 5120.6 5130.1 5133.2 5150.1 4577.2 4613.1 4630.7 4646.1 4664.2 5108.6 5145.4 5146.6 5177.4 5202.6 4930.5 4933.9 4966.1 4975.9 4982.3 4869.9 4954.1 4995.1 5068.3 5069.9 4967.2 4989.6 4994.1 4995.0 5016.4 4953.1 4960.0 4960.3 4963.2 4992.6 3995.8 4020.6 4135.5 4149.2 4191.4 3654.0 3668.3 3673.1 3706.0 3715.1 4332.2 4332.5 4335.2 4359.9 4378.4 4869.9 4957.6 4986.5 4999.5 5051.1 4278.5 4302.9 4340.9 4349.0 4350.1 4383.3 4385.2 4420.6 4427.1 4431.0 4620.3 4735.3 4780.5 4791.2 4797.9 5051.0 5053.8 5080.9 5098.1 5140.1 4839.9 4867.1 4872.4 4874.1 4903.3 4778.8 4948.3 4962.7 4984.2 5060.1 5068.5 5079.4 5089.9 5095.5 5138.4 4920.2 4936.1 4937.1 4938.0 4989.7 4748.1 4864.5 4879.2 4912.7 4929.8 4835.3 4864.5 4894.9 4907.9 4909.6 4834.0 4976.5 4980.6 5029.6 5032.4 4782.0 4798.1 4838.8 4865.4 4909.4 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#1] ext.html Cycles:180 Average:48036.27 Median:34671.89 stddev:89428.84 (257.9%) stddev-sans-first:89608.63 06:57:17 INFO - PROCESS | 18045 | Values: 546.2 594.6 595.1 595.1 605.4 27611.4 39806.8 40413.0 40429.8 40529.6 41246.6 41654.0 41689.8 41738.4 41810.4 7382.4 7634.4 7832.4 7836.1 9934.6 9790.7 10251.5 10253.3 10259.5 10263.7 10127.3 10228.9 10231.9 10235.8 10235.9 7500.0 7735.7 7736.0 9920.6 10163.6 9805.4 10187.6 10191.5 10192.5 10203.5 38682.4 39281.6 39323.4 39357.2 39401.8 3085.3 3143.8 3332.5 3372.6 3735.7 29383.0 29456.3 29609.4 29704.7 30314.7 3280.0 3506.2 3533.3 3553.5 3592.4 280158.0 281588.0 283099.0 283282.0 283460.0 31914.5 55763.0 56639.0 56648.4 56698.4 32562.0 34652.3 34661.0 34674.1 34703.7 13116.7 13295.5 13304.7 13308.9 13315.5 9720.7 10518.9 10766.8 10769.8 10994.2 7957.6 7960.6 7977.7 8048.1 8048.8 3128.9 3141.2 3169.1 3184.9 3216.3 880.5 935.7 1017.7 1047.1 1049.7 28886.7 29040.7 29146.0 29525.6 29579.7 959.8 967.5 989.0 997.6 1028.9 15024.4 15031.3 15279.5 15317.5 15441.9 419687.0 420878.0 421680.0 422154.0 422889.0 48607.5 49651.3 49869.5 49873.5 49895.3 1090.9 1201.3 1211.8 1241.8 1241.9 28241.6 28944.3 29190.4 29751.6 29905.4 41887.2 42159.4 42292.8 42351.0 42354.8 291425.0 295862.0 295884.0 296041.0 296733.0 22493.1 23122.7 24680.1 25503.9 25581.0 42019.2 42086.8 42292.0 42851.1 43164.2 36156.0 36382.3 37320.6 37772.4 38543.8 37032.8 37637.8 37866.4 37948.2 38001.6 35593.0 36091.6 36686.4 36829.3 36933.1 30191.0 34421.8 34652.5 34669.7 34801.1 25841.7 26057.9 26122.7 26268.2 26471.1 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#2] jquery.html Cycles:180 Average:23126.76 Median:5163.52 stddev:61963.90 (1200.0%) stddev-sans-first:62114.16 06:57:17 INFO - PROCESS | 18045 | Values: 364.8 369.6 369.9 382.3 383.4 16262.0 16796.0 16882.7 17055.8 17257.8 15886.5 16208.3 16815.2 16863.7 16886.3 4884.0 4954.0 4960.1 5153.6 5153.6 3704.4 3892.5 5020.1 5531.9 5842.9 5869.8 5881.1 5917.7 5920.6 5921.1 5781.5 5820.9 5908.7 5930.7 5939.5 3348.5 4907.7 5173.4 5220.7 5222.5 19505.7 20187.3 20204.3 20205.0 20264.8 1788.0 1846.8 2180.2 2430.8 2443.7 12532.2 12778.3 12857.4 12947.8 13389.5 1546.1 1549.1 1550.7 1571.4 1636.0 57837.4 59735.0 61055.7 67503.0 69205.7 9873.7 9900.7 10080.7 10111.9 10254.7 13920.7 14001.6 14003.2 14018.9 14043.2 6979.6 7020.1 7126.0 7145.5 7199.9 6460.1 6546.4 6621.7 6700.6 6711.9 4282.3 4293.8 4339.7 4375.0 4419.9 1669.0 1686.7 1783.3 1830.2 1845.2 880.4 900.7 957.2 965.7 966.4 15805.2 16132.9 16400.5 16978.3 17033.6 802.0 886.9 913.8 921.8 938.6 9072.3 9141.8 9444.9 9570.6 9615.6 370176.0 377777.0 378170.4 378498.0 379001.0 67622.3 68808.0 69341.3 69656.0 70743.6 851.5 909.1 924.8 948.1 953.7 14625.9 14652.6 14665.3 14678.8 15112.7 27466.7 30104.7 31593.0 33364.5 35383.1 43555.0 47024.0 47097.8 47115.5 47647.3 7019.6 7174.1 7218.6 7242.6 7338.0 7952.6 9405.9 10511.5 10581.9 10711.5 8923.2 8963.6 9247.4 9289.6 9450.9 9281.7 9352.6 9583.5 9713.6 9840.6 8895.6 9069.8 9495.0 9581.5 9681.5 6788.9 7056.2 7181.2 7182.0 7403.0 8373.0 9191.9 9463.6 9570.2 9639.7 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#3] mootools.html Cycles:180 Average:5310.99 Median:5150.05 stddev:3006.94 (58.4%) stddev-sans-first:2999.70 06:57:17 INFO - PROCESS | 18045 | Values: 1226.0 1403.8 1440.2 1549.8 1777.3 6889.1 7750.9 7966.8 7978.4 8213.0 7926.9 8107.4 8118.2 8135.5 8140.3 2160.2 2192.2 2200.3 2200.5 2201.2 2167.3 2203.3 2230.5 2230.9 2232.6 2197.6 2209.4 2218.7 2224.8 2233.3 2156.0 2176.1 2181.2 2184.7 2188.6 2156.9 2169.9 2171.2 2171.6 2178.6 7810.8 7843.6 7879.5 7967.8 8234.1 4668.2 4755.3 4790.9 4793.5 4803.9 2832.6 2904.4 2949.0 2965.7 2970.6 865.2 893.6 900.5 907.7 908.7 11077.7 11230.7 11231.8 11233.7 11251.8 4088.1 4172.4 4173.3 4224.2 4300.3 8749.7 8824.7 8836.0 8848.9 8849.2 4586.7 4655.3 4663.6 4664.6 4671.5 3794.5 3850.8 3864.0 4201.9 4253.7 3390.7 3514.4 3524.4 3569.7 3569.9 1001.9 1016.5 1022.9 1031.6 1033.8 844.4 859.6 892.6 917.0 918.4 5592.1 5602.4 5756.2 5817.1 5869.3 840.2 869.2 874.6 881.7 920.6 3810.9 3823.9 3937.3 3960.2 4001.4 9794.4 10132.1 10211.5 10211.8 10227.8 9881.8 10125.0 10140.4 10197.7 10210.8 7529.1 7574.5 7595.7 7639.5 7675.9 5611.6 5685.1 5697.1 5709.9 5853.0 9167.3 9250.4 9374.1 9388.6 9417.2 9097.1 9397.7 9410.8 9524.6 9579.0 5842.4 6495.7 6514.8 6666.7 6671.4 7803.8 7825.7 7890.0 7926.0 7937.1 6908.7 7027.7 7070.9 7178.9 7181.5 6855.9 6990.2 7004.9 7076.0 7122.8 6578.1 6727.2 6727.7 6732.8 6744.4 5032.8 5043.8 5104.8 5113.6 5132.2 5071.3 5093.6 5097.9 5167.9 5235.8 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#4] prototype.html Cycles:180 Average:4082.59 Median:4482.58 stddev:1169.99 (26.1%) stddev-sans-first:1138.17 06:57:17 INFO - PROCESS | 18045 | Values: 292.9 303.6 304.6 309.9 310.1 4600.9 4758.7 4811.9 4828.0 4865.7 4656.4 4799.5 4810.4 4810.4 4822.6 3803.8 3819.0 3820.8 3830.6 3843.6 3611.3 3633.9 3802.8 3811.8 3824.7 3753.7 3766.4 3786.9 3788.3 3799.9 3758.6 3766.9 3779.9 3780.3 3781.3 3351.6 3368.2 3368.8 3385.6 3385.8 4546.0 4602.4 4603.3 4620.9 4658.3 4317.7 4324.2 4339.8 4341.7 4360.7 5005.9 5009.3 5015.3 5028.4 5055.6 3571.3 3635.7 3658.6 3712.1 3715.2 5294.9 5307.2 5319.2 5321.9 5328.3 3795.8 3801.5 3804.4 3804.9 3812.6 3692.9 3863.6 3864.4 3876.5 3902.1 4300.3 4308.8 4309.2 4317.6 4331.6 4760.5 5012.2 5021.9 5035.2 5044.8 1279.4 1298.3 1303.2 1312.6 1323.7 834.3 848.9 861.8 865.4 870.6 3964.4 3978.9 3978.9 3980.8 4012.3 4605.6 4605.7 4616.5 4618.8 4622.0 3967.8 3972.7 3977.8 3987.4 3998.7 2358.7 2444.8 2456.6 2467.6 2468.8 4389.5 4405.3 4407.6 4431.9 4439.3 4645.9 4696.5 4714.9 4723.2 4732.8 4174.7 4361.8 4418.1 4490.3 4493.8 4645.2 4659.9 4696.4 4704.7 4720.4 4502.8 4521.3 4530.7 4559.7 4583.5 4396.5 4432.2 4474.9 4640.3 5053.4 3696.0 3697.2 3712.4 3718.6 3718.7 5017.9 5264.5 5269.9 5280.7 5285.9 4927.2 5083.2 5085.5 5097.9 5125.4 5063.8 5066.2 5073.8 5092.2 5114.9 4835.6 5019.7 5028.9 5035.9 5061.0 5123.5 5132.7 5149.6 5150.9 5160.8 5018.4 5033.7 5038.9 5043.9 5043.9 06:57:17 INFO - PROCESS | 18045 | 06:57:17 INFO - PROCESS | 18045 | [#5] yui.html Cycles:180 Average:13280.52 Median:43644.45 stddev:15093.54 (34.6%) stddev-sans-first:15106.05 06:57:17 INFO - PROCESS | 18045 | Values: 644.3 647.9 650.5 711.7 729.4 12032.3 12539.0 13489.6 13984.4 14077.2 13895.4 13953.9 13968.0 14007.0 14023.8 618.8 777.9 810.3 815.0 816.5 812.4 819.0 819.7 820.2 821.2 850.6 854.5 861.0 861.1 861.7 657.3 825.4 853.9 858.0 858.3 622.5 626.4 626.8 627.5 627.5 12667.4 12763.6 12785.5 12788.4 12813.8 11436.1 11769.8 11919.6 11958.7 12081.0 10874.4 10996.4 11126.8 11306.9 11400.3 4085.4 4101.2 4162.5 4181.4 4189.7 43807.6 44006.6 46382.0 46915.5 47789.0 9652.6 9777.2 9788.7 9855.6 9870.9 17482.6 17487.4 17514.0 17520.3 17531.6 6724.4 6796.0 6830.8 6930.0 7009.2 3667.2 3671.1 3742.9 3773.7 3845.9 2834.5 2919.7 2941.2 2942.7 2943.1 532.8 540.2 545.8 548.3 551.9 430.6 542.7 586.5 608.6 608.9 8194.2 8436.8 8442.4 8549.0 8626.8 575.9 603.6 606.0 607.1 613.4 3818.4 3849.9 3864.5 3881.5 3901.6 53084.2 55529.0 56233.4 56274.4 56353.0 47780.5 48298.5 49619.5 50772.2 51066.5 43481.3 44830.6 45559.3 46020.0 46690.0 8284.8 8441.5 8673.4 8808.2 9141.7 29985.7 30479.2 31020.4 31230.1 31684.5 37320.6 39942.4 40052.6 40369.2 40643.0 11047.7 11053.6 11383.3 11387.1 11554.1 11416.3 11614.4 11786.0 11823.8 11951.3 10912.2 11143.2 11393.7 11537.4 11542.7 10817.9 10972.8 11102.6 11172.4 11190.7 10999.3 11244.3 11550.2 11653.8 11657.6 9376.7 9484.0 9675.6 9695.4 9902.8 9372.2 10000.7 10020.2 10076.0 10123.7 06:57:17 INFO - PROCESS | 18045 | -------- Summary: end -------- 06:57:17 INFO - PROCESS | 18045 | 06:57:18 INFO - TEST-INFO | 18045: exit 0 06:57:18 INFO - TEST-OK | dromaeo_css | took 1118837ms 06:57:18 INFO - TEST-START | kraken 06:57:18 INFO - operating with platform_type : linux_ 06:57:18 INFO - Initialising browser for kraken test... 06:57:18 INFO - TEST-INFO | started process 18229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvha77j/profile http://localhost:38528/getInfo.html) 06:57:22 INFO - PROCESS | 18229 | __metrics Screen width/height:1600/1200 06:57:22 INFO - PROCESS | 18229 | colorDepth:24 06:57:22 INFO - PROCESS | 18229 | Browser inner width/height: 1024/697 06:57:22 INFO - PROCESS | 18229 | __metrics 06:57:23 ERROR - PROCESS | 18229 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:57:24 INFO - TEST-INFO | 18229: exit 0 06:57:24 INFO - Browser initialized. 06:57:24 INFO - Running cycle 1/1 for kraken test... 06:57:24 INFO - TEST-INFO | started process 18314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvha77j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:36 INFO - PROCESS | 18314 | RSS: Main: 157315072 06:57:36 INFO - PROCESS | 18314 | 06:57:39 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection) 06:57:40 INFO - PROCESS | 18314 | RSS: Main: 215486464 06:57:40 INFO - PROCESS | 18314 | 06:57:42 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-dft) 06:57:43 INFO - PROCESS | 18314 | RSS: Main: 204029952 06:57:43 INFO - PROCESS | 18314 | 06:57:46 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-fft) 06:57:47 INFO - PROCESS | 18314 | RSS: Main: 270938112 06:57:47 INFO - PROCESS | 18314 | 06:57:49 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator) 06:57:50 INFO - PROCESS | 18314 | RSS: Main: 180748288 06:57:50 INFO - PROCESS | 18314 | 06:57:52 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:57:52 INFO - PROCESS | 18314 | RSS: Main: 184238080 06:57:52 INFO - PROCESS | 18314 | 06:57:56 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom) 06:57:56 INFO - PROCESS | 18314 | RSS: Main: 220684288 06:57:56 INFO - PROCESS | 18314 | 06:58:00 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:00 INFO - PROCESS | 18314 | RSS: Main: 216944640 06:58:00 INFO - PROCESS | 18314 | 06:58:03 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial) 06:58:04 INFO - PROCESS | 18314 | RSS: Main: 219885568 06:58:04 INFO - PROCESS | 18314 | 06:58:06 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:06 INFO - PROCESS | 18314 | RSS: Main: 209940480 06:58:06 INFO - PROCESS | 18314 | 06:58:08 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:09 INFO - PROCESS | 18314 | RSS: Main: 210862080 06:58:09 INFO - PROCESS | 18314 | 06:58:11 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:12 INFO - PROCESS | 18314 | RSS: Main: 216965120 06:58:12 INFO - PROCESS | 18314 | 06:58:14 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:15 INFO - PROCESS | 18314 | RSS: Main: 222908416 06:58:15 INFO - PROCESS | 18314 | 06:58:18 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:18 INFO - PROCESS | 18314 | RSS: Main: 220381184 06:58:18 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | Cycle 1(1): loaded http://localhost:38528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38528/tests/kraken/driver.html?testName=ai-astar) 06:58:20 INFO - PROCESS | 18314 | RSS: Main: 263725056 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | __start_tp_report 06:58:20 INFO - PROCESS | 18314 | _x_x_mozilla_page_load 06:58:20 INFO - PROCESS | 18314 | _x_x_mozilla_page_load_details 06:58:20 INFO - PROCESS | 18314 | |i|pagename|runs| 06:58:20 INFO - PROCESS | 18314 | |0;ai-astar;114;112;114;115;115;113;115;113;114;115 06:58:20 INFO - PROCESS | 18314 | |1;audio-beat-detection;159;129;138;183;133;136;158;131;185;132 06:58:20 INFO - PROCESS | 18314 | |2;audio-dft;160;162;160;161;161;160;163;162;163;161 06:58:20 INFO - PROCESS | 18314 | |3;audio-fft;75;75;76;105;84;76;75;76;109;77 06:58:20 INFO - PROCESS | 18314 | |4;audio-oscillator;86;86;115;84;85;84;126;86;84;120 06:58:20 INFO - PROCESS | 18314 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;117 06:58:20 INFO - PROCESS | 18314 | |6;imaging-darkroom;146;146;146;145;145;147;146;146;147;147 06:58:20 INFO - PROCESS | 18314 | |7;imaging-desaturate;95;95;95;94;95;97;95;95;94;95 06:58:20 INFO - PROCESS | 18314 | |8;json-parse-financial;65;64;65;65;65;66;65;64;65;71 06:58:20 INFO - PROCESS | 18314 | |9;json-stringify-tinderbox;64;66;66;65;66;65;67;68;66;65 06:58:20 INFO - PROCESS | 18314 | |10;stanford-crypto-aes;83;82;82;89;83;84;84;85;127;83 06:58:20 INFO - PROCESS | 18314 | |11;stanford-crypto-ccm;143;139;132;130;131;129;131;132;143;135 06:58:20 INFO - PROCESS | 18314 | |12;stanford-crypto-pbkdf2;169;169;172;170;171;169;166;167;166;175 06:58:20 INFO - PROCESS | 18314 | |13;stanford-crypto-sha256-iterative;67;67;68;69;66;71;66;66;69;67 06:58:20 INFO - PROCESS | 18314 | __end_tp_report 06:58:20 INFO - PROCESS | 18314 | __start_cc_report 06:58:20 INFO - PROCESS | 18314 | _x_x_mozilla_cycle_collect,1853 06:58:20 INFO - PROCESS | 18314 | __end_cc_report 06:58:20 INFO - PROCESS | 18314 | __startTimestamp1464789500984__endTimestamp 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | ------- Summary: start ------- 06:58:20 INFO - PROCESS | 18314 | Number of tests: 14 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.05 (0.9%) stddev-sans-first:1.12 06:58:20 INFO - PROCESS | 18314 | Values: 114.0 112.0 114.0 115.0 115.0 113.0 115.0 113.0 114.0 115.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:148.00 stddev:21.57 (14.6%) stddev-sans-first:22.54 06:58:20 INFO - PROCESS | 18314 | Values: 159.0 129.0 138.0 183.0 133.0 136.0 158.0 131.0 185.0 132.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.13 06:58:20 INFO - PROCESS | 18314 | Values: 160.0 162.0 160.0 161.0 161.0 160.0 163.0 162.0 163.0 161.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.06 (17.2%) stddev-sans-first:13.55 06:58:20 INFO - PROCESS | 18314 | Values: 75.0 75.0 76.0 105.0 84.0 76.0 75.0 76.0 109.0 77.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.50 stddev:17.28 (20.5%) stddev-sans-first:17.98 06:58:20 INFO - PROCESS | 18314 | Values: 86.0 86.0 115.0 84.0 85.0 84.0 126.0 86.0 84.0 120.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:58:20 INFO - PROCESS | 18314 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 06:58:20 INFO - PROCESS | 18314 | Values: 146.0 146.0 146.0 145.0 145.0 147.0 146.0 146.0 147.0 147.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 06:58:20 INFO - PROCESS | 18314 | Values: 95.0 95.0 95.0 94.0 95.0 97.0 95.0 95.0 94.0 95.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 06:58:20 INFO - PROCESS | 18314 | Values: 65.0 64.0 65.0 65.0 65.0 66.0 65.0 64.0 65.0 71.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.00 06:58:20 INFO - PROCESS | 18314 | Values: 64.0 66.0 66.0 65.0 66.0 65.0 67.0 68.0 66.0 65.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:83.50 stddev:13.78 (16.5%) stddev-sans-first:14.49 06:58:20 INFO - PROCESS | 18314 | Values: 83.0 82.0 82.0 89.0 83.0 84.0 84.0 85.0 127.0 83.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.50 stddev:5.30 (4.0%) stddev-sans-first:4.64 06:58:20 INFO - PROCESS | 18314 | Values: 143.0 139.0 132.0 130.0 131.0 129.0 131.0 132.0 143.0 135.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:2.80 (1.7%) stddev-sans-first:2.96 06:58:20 INFO - PROCESS | 18314 | Values: 169.0 169.0 172.0 170.0 171.0 169.0 166.0 167.0 166.0 175.0 06:58:20 INFO - PROCESS | 18314 | 06:58:20 INFO - PROCESS | 18314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.65 (2.4%) stddev-sans-first:1.73 06:58:20 INFO - PROCESS | 18314 | Values: 67.0 67.0 68.0 69.0 66.0 71.0 66.0 66.0 69.0 67.0 06:58:20 INFO - PROCESS | 18314 | -------- Summary: end -------- 06:58:20 INFO - PROCESS | 18314 | 06:58:22 INFO - TEST-INFO | 18314: exit 0 06:58:22 INFO - TEST-OK | kraken | took 63819ms 06:58:22 INFO - SUITE-END | took 1182s 06:58:22 INFO - Completed test suite (00:19:42) 06:58:22 INFO - javascript benchmark 06:58:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.155790147153, 2686.0196028449595, 2717.8505182214976, 2738.014314846655, 2738.8219765715226, 4515.412996310475, 4595.080983803236, 4641.3038044293335, 4753.3820603321565, 4800.135975524404, 4588.059447813199, 4626.375439315691, 4645.605123564493, 4661.510541393156, 4666.23007203811, 4276.828926842938, 4285.035866929947, 4297.097609502009, 4312.439382880221, 4428.6014258716705, 4358.455193100863, 4401.295792673173, 4406.647468202536, 4439.977800110995, 4450.310201918708, 4190.706650534464, 4356.695031347807, 4382.824687012516, 4398.010447649253, 4403.471583409995, 4211.199872024336, 4249.723767955073, 4252.87241382759, 4272.786360681954, 4315.115401342718, 4212.073343864345, 4272.01743598974, 4287.378330142144, 4289.6997210195295, 4325.199838029975, 4454.643628509712, 4619.5611416915335, 4638.420197475316, 4641.025384669224, 4642.164410406125, 4978.452370239271, 4996.100701873697, 5051.848444546669, 5118.488151184889, 5126.384833819928, 5117.7185254810975, 5120.641555091145, 5130.050940576006, 5133.153029750087, 5150.072986862363, 4577.244754615518, 4613.123506533748, 4630.72215667061, 4646.070785842845, 4664.230401983703, 5108.591312694975, 5145.382554093533, 5146.588272938156, 5177.430482646906, 5202.60980426462, 4930.482299358588, 4933.9013219736125, 4966.056449274626, 4975.90048199034, 4982.302477653131, 4869.9269510957365, 4954.058728841508, 4995.125852975787, 5068.341115654941, 5069.949300507022, 4967.230079337708, 4989.55094041538, 4994.126027945095, 4994.9500504994485, 5016.423111342242, 4953.133201689762, 4960.007998400334, 4960.330355401975, 4963.205887058053, 4992.600591952708, 3995.841206050271, 4020.597940205956, 4135.524414692289, 4149.232392007489, 4191.434156388848, 3653.9817300913855, 3668.3194660645977, 3673.081729567608, 3705.9814700926863, 3715.108373990223, 4332.1985432695055, 4332.458442694663, 4335.176316499918, 4359.869203923888, 4378.408914796525, 4869.902601947942, 4957.628177886673, 4986.476419975923, 4999.475055119233, 5051.1413059779925, 4278.486581610165, 4302.913941721211, 4340.891477713082, 4349.021470169187, 4350.129974005148, 4383.342498625232, 4385.188740083095, 4420.557944205618, 4427.114577084596, 4430.955690443055, 4620.330052142488, 4735.289706544046, 4780.450248221499, 4791.233402655558, 4797.928031079537, 5050.9747451263975, 5053.797848086036, 5080.923786143285, 5098.056859481007, 5140.100482415488, 4839.879003024953, 4867.123917694849, 4872.366592342973, 4874.147024270809, 4903.26451032348, 4778.761061946958, 4948.282499037691, 4962.702237865739, 4984.22744474607, 5060.139776237975, 5068.518490743373, 5079.441261461162, 5089.923651145162, 5095.490450954875, 5138.3577052868395, 4920.212765957573, 4936.136176169228, 4937.1113199624415, 4938.012397520439, 4989.675671081368, 4748.074125545486, 4864.464908859952, 4879.170541008109, 4912.6561140719805, 4929.827456039022, 4835.347228124158, 4864.464908859952, 4894.877628059327, 4907.926381104215, 4909.582685471775, 4833.95166048335, 4976.477469865612, 4980.551750342342, 5029.572486338556, 5032.421271553818, 4782.043591281688, 4798.1123492154065, 4838.806447742191, 4865.367502224688, 4909.386326709161], "value": 4610.64666856629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.218906963043, 594.6224147666233, 595.0924839619577, 595.1073389915127, 605.3583201806086, 27611.447771044568, 39806.800965995164, 40413.0, 40429.79785101078, 40529.59470405295, 41246.58753412465, 41654.0, 41689.7915510422, 41738.373924391155, 41810.37284440736, 7382.446316526255, 7634.35108015818, 7832.373410127205, 7836.0596728392675, 9934.552945117486, 9790.70627881161, 10251.487425628726, 10253.282270241049, 10259.538320775582, 10263.743406414826, 10127.29108962373, 10228.89771102287, 10231.948840255789, 10235.795284094314, 10235.897641023606, 7500.0, 7735.690572377154, 7735.9613201933635, 9920.603175872957, 10163.59345626174, 9805.411675299434, 10187.643432479828, 10191.541380637815, 10192.490375481197, 10203.540840662114, 38682.41976370357, 39281.60718392837, 39323.41014884779, 39357.21285574301, 39401.80299098515, 3085.2595377109556, 3143.795653282529, 3332.500124981248, 3372.5952885653633, 3735.6637902588627, 29383.0, 29456.263593410124, 29609.40781184386, 29704.70295297041, 30314.69685303163, 3279.967200328014, 3506.2461570762407, 3533.3463309287863, 3553.502509648651, 3592.4431713084255, 280158.0, 281588.0, 283099.0, 283281.99999999796, 283460.0, 31914.52128218032, 55763.0, 56639.0, 56648.43351566514, 56698.43301567014, 32562.0, 34652.30695386128, 34661.0, 34674.133146671535, 34703.652963470544, 13116.672083197805, 13295.468181272834, 13304.667383315495, 13308.866911330957, 13315.467381304834, 9720.708378748508, 10518.947405263078, 10766.838497422545, 10769.83845242322, 10994.240921452689, 7957.6021198939825, 7960.641771120314, 7977.720779772796, 8048.074471435742, 8048.798780030546, 3128.9374212515622, 3141.1989942564956, 3169.128489665314, 3184.8885289014775, 3216.32457183994, 880.4849163239577, 935.6678379175431, 1017.7404761785697, 1047.1047254597363, 1049.6850944716555, 28886.711132888402, 29040.7095929038, 29146.0, 29525.557116643267, 29579.704202957695, 959.7984423271191, 967.4823969176598, 988.9703308900745, 997.6358629100326, 1028.943408112561, 15024.399024039134, 15031.323590438456, 15279.541613751606, 15317.46388876384, 15441.922790386201, 419687.0, 420878.0, 421680.0, 422154.0, 422889.0, 48607.51392486101, 49651.25523117156, 49869.50130498649, 49873.50126498689, 49895.25157122646, 1090.8527348807968, 1201.3092471828734, 1211.7697637449032, 1241.7578572178338, 1241.937903104841, 28241.57637635396, 28944.276393090342, 29190.41619167647, 29751.55372669455, 29905.401891962472, 41887.162256755306, 42159.36760948527, 42292.78853605712, 42351.0, 42354.78822605867, 291425.0, 295862.0, 295884.0, 296041.0, 296733.0, 22493.100275988778, 23122.653160202946, 24680.13619523308, 25503.872480637478, 25581.0, 42019.1596168081, 42086.78956605197, 42292.0, 42851.14297714091, 43164.19432736862, 36156.0, 36382.27235455223, 37320.62679373172, 37772.43341349827, 38543.80728096454, 37032.814835925645, 37637.78116318675, 37866.432003520524, 37948.24103517969, 38001.61998379981, 35593.0, 36091.63908360988, 36686.449703255006, 36829.26341473102, 36933.076673082316, 30191.0, 34421.82789086038, 34652.48021279733, 34669.65330346664, 34801.12997175091, 25841.68061349357, 26057.869710651325, 26122.738772612032, 26268.21195364142, 26471.073512426974], "value": 17198.280575439523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.8412940370938, 369.6211383332084, 369.8834867016889, 382.3022983055924, 383.3808399434912, 16262.0, 16796.0, 16882.66234675306, 17055.82944170558, 17257.82742172578, 15886.52340429786, 16208.270627821747, 16815.15924203788, 16863.747043794323, 16886.324547018103, 4884.023195360925, 4953.9504604953845, 4960.131976904046, 5153.56194723449, 5153.6392452528335, 3704.425813998821, 3892.5328960524635, 5020.146575082244, 5531.944680553183, 5842.912356314638, 5869.7652093916195, 5881.088431293135, 5917.674527900964, 5920.585559010871, 5921.052631578948, 5781.4507621775865, 5820.941790582104, 5908.67502287374, 5930.673812940287, 5939.5248380129915, 3348.514465402503, 4907.656464047483, 5173.405058418292, 5220.660657057317, 5222.451642577513, 19505.707414388795, 20187.293444729363, 20204.29284975019, 20205.0, 20264.79735202644, 1787.9642407151784, 1846.778386593604, 2180.160638154306, 2430.829841911067, 2443.6701045358827, 12532.185407948546, 12778.297193654345, 12857.4214160363, 12947.805782913263, 13389.464421423132, 1546.1109861829493, 1549.1170033081148, 1550.6821101674243, 1571.363597742916, 1636.0, 57837.42162578362, 59735.0, 61055.69472152655, 67503.0, 69205.65397172981, 9873.716416865762, 9900.653477128266, 10080.697579072494, 10111.949440252753, 10254.692359229235, 13920.651983700489, 14001.649958751113, 14003.159810411204, 14018.859811401959, 14043.157410555195, 6979.581225126407, 7020.087388639444, 7125.964370178116, 7145.535540189871, 7199.856002879913, 6460.095586617877, 6546.443552298013, 6621.702023408958, 6700.597964122071, 6711.899321510181, 4282.293421585404, 4293.763842988666, 4339.7396156230725, 4374.956250437519, 4419.867403977886, 1668.9569019362898, 1686.6879627268995, 1783.3428191993835, 1830.229101736265, 1845.1512304340154, 880.3705350674298, 900.7432881628836, 957.1959553974694, 965.7295957132014, 966.3766870368713, 15805.209739512979, 16132.919335403249, 16400.507984760476, 16978.320867165174, 17033.574160646083, 801.9719309824128, 886.8625363068735, 913.7715571107224, 921.829461549602, 938.6433155400904, 9072.319576031825, 9141.81716365669, 9444.905550944402, 9570.56932438042, 9615.56729947154, 370176.0, 377777.0, 378170.41892277467, 378498.0, 379001.0, 67622.32377676258, 68808.0, 69341.3065869345, 69656.0, 70743.6462817693, 851.5188918261039, 909.0818273543769, 924.8057907839294, 948.0850978805486, 953.7043516509904, 14625.92687036558, 14652.560423187322, 14665.343037728226, 14678.779818302948, 15112.697746045238, 27466.725332747217, 30104.698953011066, 31593.0, 33364.49953250655, 35383.11542211465, 43555.0, 47024.0, 47097.76451117722, 47115.528844712484, 47647.28529072136, 7019.5788252705, 7174.139103307636, 7218.566885986857, 7242.637868106679, 7338.0, 7952.602369881367, 9405.858912116188, 10511.526981285708, 10581.947090264499, 10711.464426778473, 8923.15230053144, 8963.641454342014, 9247.39891907024, 9289.62841486333, 9450.905490945277, 9281.67514137002, 9352.625894964125, 9583.520823958635, 9713.611455541699, 9840.557174927002, 8895.555222238732, 9069.77325566866, 9495.0, 9581.473018984023, 9681.467519286507, 6788.93211067883, 7056.188538317954, 7181.174164971095, 7181.964090179516, 7402.9629851850395, 8372.958135209285, 9191.942926563263, 9463.621455141718, 9570.234381249622, 9639.662611808553], "value": 7978.519279635815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.9754804903896, 1403.8455769865313, 1440.200688617817, 1549.7985261915956, 1777.2535535075276, 6889.069975553299, 7750.92249077509, 7966.800829979254, 7978.401619878503, 8213.0, 7926.92073079269, 8107.35141188705, 8118.228768267005, 8135.511869287847, 8140.348772098233, 2160.243914629875, 2192.210804110527, 2200.3179014505477, 2200.515886504966, 2201.218567408571, 2167.295628920607, 2203.3059586230365, 2230.520438105807, 2230.8661480311152, 2232.598132336179, 2197.6154173019736, 2209.4034610655112, 2218.689383486313, 2224.7663995280504, 2233.3076746208726, 2156.0156909479183, 2176.053416763713, 2181.1820567287186, 2184.683220932956, 2188.6388745856993, 2156.8813715245656, 2169.9240526581493, 2171.174953517653, 2171.576542574199, 2178.6078505868936, 7810.765677029642, 7843.568603726792, 7879.487833290817, 7967.840643187162, 8234.094249632535, 4668.183067963093, 4755.334253204554, 4790.904181916342, 4793.496682848286, 4803.927941080887, 2832.5751137329357, 2904.4481548505714, 2949.0120809528835, 2965.747911427531, 2970.628671416073, 865.2169786343369, 893.6461261189304, 900.4507250577143, 907.6823111910778, 908.7228395339419, 11077.723056923562, 11230.719232019183, 11231.775364492665, 11233.66299011031, 11251.83122253167, 4088.100617864065, 4172.436721042681, 4173.269677806372, 4224.197402493516, 4300.333448315516, 8749.65001399937, 8824.691135810215, 8836.0, 8848.867266991001, 8849.247813935759, 4586.678932474695, 4655.2784318430695, 4663.556962088596, 4664.626829853603, 4671.48613652498, 3794.4877441545036, 3850.825498223013, 3863.9613603864163, 4201.915961680749, 4253.744775313491, 3390.677885600864, 3514.367413865478, 3524.3656141894194, 3569.660882216185, 3569.910752231163, 1001.8547310639916, 1016.517154351677, 1022.9386236825666, 1031.6131450705984, 1033.844923261517, 844.396256676467, 859.6389516403126, 892.5849479991834, 917.0050495212769, 918.4397517514311, 5592.105263157875, 5602.439756024365, 5756.194132821408, 5817.069268916953, 5869.266341707286, 840.1766269056237, 869.2090197919863, 874.6282829797311, 881.6781874615847, 920.5719340506563, 3810.904727381838, 3823.9426408603895, 3937.251922134785, 3960.2277555876904, 4001.4397984282223, 9794.363366381162, 10132.088112069801, 10211.489425528842, 10211.846822297672, 10227.795444091076, 9881.752956176153, 10125.0, 10140.442275674908, 10197.74505637365, 10210.846837297446, 7529.134149572759, 7574.469787114849, 7595.734149304748, 7639.503432276884, 7675.923240767633, 5611.57913156523, 5685.147227915681, 5697.145428185805, 5709.857253568694, 5853.0, 9167.312451566026, 9250.444973301623, 9374.109459601326, 9388.624455021996, 9417.152456278967, 9097.13577210164, 9397.671081512115, 9410.764730881509, 9524.619015239312, 9578.952105239709, 5842.444967728059, 6495.707693153914, 6514.804555863332, 6666.699998500176, 6671.366220209073, 7803.843923121619, 7825.686972521035, 7889.960550197212, 7926.048874135141, 7937.126916039116, 6908.723651053901, 7027.7188912442925, 7070.893936591058, 7178.928210717826, 7181.533200341961, 6855.931440685728, 6990.196127445409, 7004.894926576208, 7076.0, 7122.821929451805, 6578.079068930258, 6727.159105111861, 6727.663616819042, 6732.831679208059, 6744.393004629607, 5032.773525191448, 5043.798248070036, 5104.846854594368, 5113.590912727047, 5132.178851383761, 5071.315372424823, 5093.592512598909, 5097.92353114711, 5167.922481162861, 5235.764390602356], "value": 4240.108013236676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8901661876796, 303.5810581397671, 304.6496528991661, 309.9364630250799, 310.08215681582516, 4600.90798184037, 4758.714477131366, 4811.903761924759, 4827.961988172542, 4865.732384718839, 4656.44122705275, 4799.472058073609, 4810.39870016248, 4810.412563853929, 4822.565969062784, 3803.8098095095274, 3818.9618103818952, 3820.77075375477, 3830.578636349999, 3843.615638436162, 3611.313850368435, 3633.890983270493, 3802.8478860845535, 3811.8284677189454, 3824.694024478035, 3753.7184711146638, 3766.435034744783, 3786.8863934081883, 3788.299164654548, 3799.905002374935, 3758.586555478895, 3766.924661506782, 3779.9433008504893, 3780.319542482352, 3781.2626537825136, 3351.6480769519094, 3368.2253081791323, 3368.79787212768, 3385.6445073267446, 3385.796852188852, 4546.0, 4602.412167802103, 4603.296780191351, 4620.907581848344, 4658.324542941288, 4317.740935543878, 4324.243257429937, 4339.7830108494445, 4341.696081274312, 4360.694751367406, 5005.873678422362, 5009.34691551787, 5015.348004759395, 5028.41604894457, 5055.570276526463, 3571.2679799953057, 3635.745497815154, 3658.646300868669, 3712.1462063725226, 3715.1826598148364, 5294.92057619136, 5307.203919412081, 5319.17552779316, 5321.920171197435, 5328.254044433782, 3795.848166073326, 3801.5248093988253, 3804.4293355996824, 3804.885853424402, 3812.5615554211067, 3692.9261414771554, 3863.632954869283, 3864.439656249828, 3876.534815822063, 3902.1220225449047, 4300.333448315516, 4308.784560771949, 4309.224339618836, 4317.633001194934, 4331.5884990925815, 4760.476347601761, 5012.223105418666, 5021.874453138701, 5035.1873325602755, 5044.798208071709, 1279.3986826191674, 1298.2794549025193, 1303.1529505821293, 1312.5602923020704, 1323.6889331007205, 834.3241974001079, 848.8710015679131, 861.7587075618836, 865.3596338709435, 870.5647176411794, 3964.4053391991433, 3978.8806335809973, 3978.8806335809973, 3980.8407663693706, 4012.294774720732, 4605.631549476034, 4605.746683932416, 4616.492185859553, 4618.838340658061, 4621.976890115528, 3967.8412863485714, 3972.7020473464604, 3977.7525697981127, 3987.4218238355274, 3998.6801055915457, 2358.6933698619414, 2444.841085329448, 2456.557819592455, 2467.580511313081, 2468.790152837029, 4389.517153113219, 4405.31717583775, 4407.647388208936, 4431.933520997188, 4439.267520859086, 4645.907081858344, 4696.483386827515, 4714.905701886011, 4723.220668589713, 4732.834350797705, 4174.707770456039, 4361.847335343247, 4418.1222980233915, 4490.259107247398, 4493.842715504941, 4645.23481077202, 4659.860204193879, 4696.38946936896, 4704.67067305299, 4720.409948756405, 4502.7523486207265, 4521.299198624219, 4530.728156310632, 4559.674565971312, 4583.518730533246, 4396.494403143552, 4432.246518091868, 4474.910501790011, 4640.280756482751, 5053.444121146745, 3695.981520092382, 3697.186618943828, 3712.424574191005, 3718.5537735470834, 3718.7396882217986, 5017.874553136201, 5264.52619264268, 5269.947300526946, 5280.683159010472, 5285.920711189412, 4927.236278376858, 5083.161278389024, 5085.4914508548845, 5097.92353114711, 5125.410577783603, 5063.8480845574695, 5066.214736715815, 5073.822416215415, 5092.210707340369, 5114.872128196825, 4835.567778159683, 5019.698818070928, 5028.899422011613, 5035.949640503548, 5060.974695126648, 5123.487651234846, 5132.666376685504, 5149.613778966517, 5150.871228219325, 5160.845174644766, 5018.422881368543, 5033.672811267403, 5038.949610503848, 5043.87390315245, 5043.949560504348], "value": 3716.5434532054346, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.2687549631169, 647.9222493300805, 650.5381179362649, 711.7153138744504, 729.4164668265388, 12032.33822139782, 12539.0, 13489.59531214064, 13984.37070331835, 14077.225752583603, 13895.374708138133, 13953.860461395383, 13968.0, 14007.0195086344, 14023.789643155334, 618.7834258009706, 777.8755399136139, 810.3112354498688, 815.0097631377874, 816.510093943635, 812.378530424223, 819.0417211862106, 819.6516480495766, 820.1634332980357, 821.2362502872327, 850.5619605902965, 854.5257382152903, 861.0270394454258, 861.1130535548396, 861.7156338408311, 657.2507341630545, 825.3520986025941, 853.9103394143588, 858.0175698824874, 858.3476557816042, 622.5299898576591, 626.4362074133271, 626.8056902360237, 627.4635186915167, 627.5230824573312, 12667.429965651569, 12763.617091487271, 12785.488580456771, 12788.360581970957, 12813.807792883114, 11436.142289328334, 11769.764604707858, 11919.582814601446, 11958.701032474171, 12081.0, 10874.401907895062, 10996.395198264092, 11126.833097503462, 11306.886931130748, 11400.315981041163, 4085.428040074392, 4101.179764047172, 4162.458880345535, 4181.372794080882, 4189.72766770162, 43807.561924380665, 44006.55993440057, 46382.0, 46915.53084469146, 47789.0, 9652.613895444245, 9777.168940639984, 9788.657396991071, 9855.55649995752, 9870.851937220947, 17482.56293592645, 17487.387941422243, 17514.0, 17520.29918803259, 17531.56171095733, 6724.4284235840505, 6796.048553202556, 6830.795076147723, 6929.965350173217, 7009.1589009319205, 3667.1748856507606, 3671.1372827385544, 3742.8877133686033, 3773.698104151716, 3845.942310865339, 2834.489791837489, 2919.737223649839, 2941.2205765472168, 2942.7204415580914, 2943.0876428307292, 532.8108521474899, 540.1533916261282, 545.8389775016379, 548.2543740512899, 551.8647931256787, 430.5608279554899, 542.7150745858456, 586.4783606297909, 608.6165715599144, 608.9421504957022, 8194.180581941759, 8436.789080273042, 8442.409031367746, 8549.0, 8626.78433039179, 575.9107338362561, 603.5533705058313, 606.0182504342905, 607.1348328631682, 613.4111253196892, 3818.4463252828186, 3849.9037524061564, 3864.4589757433982, 3881.4753172645273, 3901.6098390160755, 53084.20373694398, 55529.0, 56233.43766562282, 56274.43725562692, 56353.0, 47780.52219477761, 48298.517014830104, 49619.50380496149, 50772.23841642378, 51066.48933510692, 43481.347779783326, 44830.55169448264, 45559.31661025087, 46020.0, 46690.0, 8284.834303313779, 8441.493510389397, 8673.392862499564, 8808.163224493663, 9141.725748227564, 29985.700142999165, 30479.238019048815, 31020.379592408477, 31230.063098107094, 31684.5247321295, 37320.62679373172, 39942.40086398764, 40052.599474004885, 40369.1926161481, 40643.0, 11047.668569942593, 11053.557857685924, 11383.260088094248, 11387.089032877515, 11554.133439991867, 11416.257943233995, 11614.419279035845, 11786.0, 11823.76352472963, 11951.282923024646, 10912.181586381212, 11143.164262680493, 11393.715157120807, 11537.365444900612, 11542.653720388402, 10817.945910270399, 10972.835407469054, 11102.61140860066, 11172.441377931233, 11190.66428007161, 10999.34003959765, 11244.26912250701, 11550.191486595857, 11653.76692466129, 11657.591984280509, 9376.67181648639, 9484.0, 9675.612975480903, 9695.418274903528, 9902.752431189278, 9372.1565059145, 10000.69997900035, 10020.24848136378, 10076.0, 10123.7469063274], "value": 6111.1353472631945, "unit": "score"}], "name": "dromaeo_css", "value": 6273.010349695743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 114.0, 115.0, 115.0, 113.0, 115.0, 113.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 138.0, 183.0, 133.0, 136.0, 158.0, 131.0, 185.0, 132.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 160.0, 163.0, 162.0, 163.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 84.0, 76.0, 75.0, 76.0, 109.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 115.0, 84.0, 85.0, 84.0, 126.0, 86.0, 84.0, 120.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 97.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 71.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 68.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 89.0, 83.0, 84.0, 84.0, 85.0, 127.0, 83.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 139.0, 132.0, 130.0, 131.0, 129.0, 131.0, 132.0, 143.0, 135.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 172.0, 170.0, 171.0, 169.0, 166.0, 167.0, 166.0, 175.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 66.0, 71.0, 66.0, 66.0, 69.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1550.9, "alertThreshold": 2.0}]} 06:58:22 INFO - Return code: 0 06:58:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:58:22 ERROR - # TBPL SUCCESS # 06:58:22 INFO - Running post-action listener: _resource_record_post_action 06:58:22 INFO - ##### 06:58:22 INFO - ##### Finished run-tests step (success) 06:58:22 INFO - ##### 06:58:22 INFO - Running post-run listener: _resource_record_post_run 06:58:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 86016; Write bytes: 522498048; Read time: 256; Write time: 394064 06:58:22 INFO - TinderboxPrint: CPU usage
13.2% 06:58:22 INFO - TinderboxPrint: I/O read bytes / time
86,016 / 256 06:58:22 INFO - TinderboxPrint: I/O write bytes / time
522,498,048 / 394,064 06:58:22 INFO - TinderboxPrint: CPU idle
8,316.1 (86.8%) 06:58:22 INFO - TinderboxPrint: CPU user
1,217.8 (12.7%) 06:58:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:58:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237088768; Read time: 0; Write time: 205844 06:58:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 86016; Write bytes: 285130752; Read time: 256; Write time: 188196 06:58:22 INFO - Running post-run listener: _upload_blobber_files 06:58:22 INFO - Blob upload gear active. 06:58:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:58:22 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 06:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:58:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:58:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:27 INFO - (blobuploader) - INFO - Done attempting. 06:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:28 INFO - (blobuploader) - INFO - Done attempting. 06:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:29 INFO - (blobuploader) - INFO - Done attempting. 06:58:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:29 INFO - Return code: 0 06:58:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:58:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9fedd305b279585590f52f7d59057358b361e0e73218a9854bc16585faa11bfc703212b6c36cbfa5e6352338bf35cd262280cfec0ac9822ca13003e5df6170a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4151f5f0423c2431d9513794967682c4bb031f80a11c84e5f2af7b8d8b104e8beda99df882e3ed3a3044c8231508877012db8c81e00eeedb7f4d4f955b7dcf9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaba70a859f610f49ca5f7c4263ee3e2e3df06408f5271ab35541fc89a299819ba9a993510c1d18bd6711a870abef7ff590e7b10de941830bc127aba5303041a"} 06:58:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:58:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:58:29 INFO - Contents: 06:58:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9fedd305b279585590f52f7d59057358b361e0e73218a9854bc16585faa11bfc703212b6c36cbfa5e6352338bf35cd262280cfec0ac9822ca13003e5df6170a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4151f5f0423c2431d9513794967682c4bb031f80a11c84e5f2af7b8d8b104e8beda99df882e3ed3a3044c8231508877012db8c81e00eeedb7f4d4f955b7dcf9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaba70a859f610f49ca5f7c4263ee3e2e3df06408f5271ab35541fc89a299819ba9a993510c1d18bd6711a870abef7ff590e7b10de941830bc127aba5303041a"} 06:58:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:29 INFO - Copying logs to upload dir... 06:58:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:58:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.902051 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-01 06:58:29.516294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:58:29.520365) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9fedd305b279585590f52f7d59057358b361e0e73218a9854bc16585faa11bfc703212b6c36cbfa5e6352338bf35cd262280cfec0ac9822ca13003e5df6170a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4151f5f0423c2431d9513794967682c4bb031f80a11c84e5f2af7b8d8b104e8beda99df882e3ed3a3044c8231508877012db8c81e00eeedb7f4d4f955b7dcf9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaba70a859f610f49ca5f7c4263ee3e2e3df06408f5271ab35541fc89a299819ba9a993510c1d18bd6711a870abef7ff590e7b10de941830bc127aba5303041a"} build_url:https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/U_WKAGfOSKqXHSUY__vQbw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9fedd305b279585590f52f7d59057358b361e0e73218a9854bc16585faa11bfc703212b6c36cbfa5e6352338bf35cd262280cfec0ac9822ca13003e5df6170a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4151f5f0423c2431d9513794967682c4bb031f80a11c84e5f2af7b8d8b104e8beda99df882e3ed3a3044c8231508877012db8c81e00eeedb7f4d4f955b7dcf9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aaba70a859f610f49ca5f7c4263ee3e2e3df06408f5271ab35541fc89a299819ba9a993510c1d18bd6711a870abef7ff590e7b10de941830bc127aba5303041a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 06:58:29.549577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:58:29.549904) ========= 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=8887e36bb8e381bfd44124ac000001a8-1464788264.376041-2111456433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 06:58:29.635396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:58:29.635715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 06:58:29.635997) ========= ========= Total master_lag: 0.20 =========