builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1463444529.02 results: success (0) buildid: 20160516143016 builduid: de00ff9e295c493daa2796e9ea061e37 revision: ae689711c21875e2f732c97264e35527c7f6b963 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.021549) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.022324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.022830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.084385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.084958) ========= 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=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 17:22:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-05-16 17:22:09 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.231104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.231657) ========= 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=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014725 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:09.283895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 17:22:09.284448) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ae689711c21875e2f732c97264e35527c7f6b963 --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 ae689711c21875e2f732c97264e35527c7f6b963 --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=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 17:22:09,580 truncating revision to first 12 chars 2016-05-16 17:22:09,580 Setting DEBUG logging. 2016-05-16 17:22:09,580 attempt 1/10 2016-05-16 17:22:09,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ae689711c218?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 17:22:11,136 unpacking tar archive at: fx-team-ae689711c218/testing/mozharness/ program finished with exit code 0 elapsedTime=1.836150 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 17:22:11.136421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:11.136949) ========= script_repo_revision: ae689711c21875e2f732c97264e35527c7f6b963 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:11.137577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:11.138010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 17:22:11.397505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-16 17:22:11.398088) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:22:11 INFO - MultiFileLogger online at 20160516 17:22:11 in /builds/slave/test 17:22:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:22:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:22:11 INFO - {'append_to_log': False, 17:22:11 INFO - 'base_work_dir': '/builds/slave/test', 17:22:11 INFO - 'blob_upload_branch': 'Fx-Team', 17:22:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:22:11 INFO - 'branch': 'Fx-Team', 17:22:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:22:11 INFO - 'config_files': ('talos/linux_config.py',), 17:22:11 INFO - 'default_actions': ('clobber', 17:22:11 INFO - 'read-buildbot-config', 17:22:11 INFO - 'download-and-extract', 17:22:11 INFO - 'populate-webroot', 17:22:11 INFO - 'create-virtualenv', 17:22:11 INFO - 'install', 17:22:11 INFO - 'run-tests'), 17:22:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:22:11 INFO - 'download_minidump_stackwalk': True, 17:22:11 INFO - 'download_symbols': 'ondemand', 17:22:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:22:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:22:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:22:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:22:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:22:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:22:11 INFO - 'installer_path': 'installer.exe', 17:22:11 INFO - 'log_level': 'info', 17:22:11 INFO - 'log_name': 'talos', 17:22:11 INFO - 'log_to_console': True, 17:22:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:22:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:22:11 INFO - 'opt_config_files': (), 17:22:11 INFO - 'pip_index': False, 17:22:11 INFO - 'sps_profile': False, 17:22:11 INFO - 'sps_profile_interval': 0, 17:22:11 INFO - 'suite': 'dromaeojs', 17:22:11 INFO - 'system_bits': '32', 17:22:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:22:11 INFO - 'title': 'talos-linux64-ix-058', 17:22:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:22:11 INFO - 'use_talos_json': True, 17:22:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:22:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:22:11 INFO - 'work_dir': 'build'} 17:22:11 INFO - ##### 17:22:11 INFO - ##### Running clobber step. 17:22:11 INFO - ##### 17:22:11 INFO - Running pre-action listener: _resource_record_pre_action 17:22:11 INFO - Running main action method: clobber 17:22:11 INFO - rmtree: /builds/slave/test/build 17:22:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:22:12 INFO - Running post-action listener: _resource_record_post_action 17:22:12 INFO - ##### 17:22:12 INFO - ##### Finished clobber step (success) 17:22:12 INFO - ##### 17:22:12 INFO - ##### 17:22:12 INFO - ##### Running read-buildbot-config step. 17:22:12 INFO - ##### 17:22:12 INFO - Running pre-action listener: _resource_record_pre_action 17:22:12 INFO - Running main action method: read_buildbot_config 17:22:12 INFO - Using buildbot properties: 17:22:12 INFO - { 17:22:12 INFO - "project": "", 17:22:12 INFO - "product": "firefox", 17:22:12 INFO - "script_repo_revision": "production", 17:22:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:22:12 INFO - "repository": "", 17:22:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:22:12 INFO - "buildid": "20160516143016", 17:22:12 INFO - "pgo_build": "True", 17:22:12 INFO - "basedir": "/builds/slave/test", 17:22:12 INFO - "buildnumber": 94, 17:22:12 INFO - "slavename": "talos-linux64-ix-058", 17:22:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:22:12 INFO - "platform": "ubuntu64_hw", 17:22:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:22:12 INFO - "branch": "fx-team", 17:22:12 INFO - "repo_path": "integration/fx-team", 17:22:12 INFO - "revision": "ae689711c21875e2f732c97264e35527c7f6b963", 17:22:12 INFO - "stage_platform": "linux64-pgo", 17:22:12 INFO - "builduid": "de00ff9e295c493daa2796e9ea061e37", 17:22:12 INFO - "slavebuilddir": "test" 17:22:12 INFO - } 17:22:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:22:12 INFO - Running post-action listener: _resource_record_post_action 17:22:12 INFO - ##### 17:22:12 INFO - ##### Finished read-buildbot-config step (success) 17:22:12 INFO - ##### 17:22:12 INFO - ##### 17:22:12 INFO - ##### Running download-and-extract step. 17:22:12 INFO - ##### 17:22:12 INFO - Running pre-action listener: _resource_record_pre_action 17:22:12 INFO - Running main action method: download_and_extract 17:22:12 INFO - mkdir: /builds/slave/test/build/tests 17:22: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')]} 17:22:12 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:12 INFO - Downloaded 1361 bytes. 17:22:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:22:12 INFO - Using the following test package requirements: 17:22:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:22:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:22:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:12 INFO - u'jsshell-linux-x86_64.zip'], 17:22:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:22:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:22:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:22:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:22:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:22:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:22:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:22:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:13 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:14 INFO - Downloaded 24023864 bytes. 17:22:14 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'] 17:22:14 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 17:22:15 INFO - Return code: 0 17:22:15 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 17:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:15 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:16 INFO - Downloaded 24023864 bytes. 17:22:16 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'] 17:22:16 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 17:22:18 INFO - Return code: 0 17:22: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')]} 17:22:18 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:19 INFO - Downloaded 10840194 bytes. 17:22:19 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'] 17:22:19 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 17:22:19 INFO - Return code: 0 17:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:19 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:22:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:22:20 INFO - Downloaded 58412024 bytes. 17:22:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:20 INFO - mkdir: /builds/slave/test/properties 17:22:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:22:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:22:20 INFO - Contents: 17:22:20 INFO - build_url:https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:22:21 INFO - Running post-action listener: _resource_record_post_action 17:22:21 INFO - Running post-action listener: set_extra_try_arguments 17:22:21 INFO - ##### 17:22:21 INFO - ##### Finished download-and-extract step (success) 17:22:21 INFO - ##### 17:22:21 INFO - ##### 17:22:21 INFO - ##### Running populate-webroot step. 17:22:21 INFO - ##### 17:22:21 INFO - Running pre-action listener: _resource_record_pre_action 17:22:21 INFO - Running main action method: populate_webroot 17:22:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:22:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:22:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:22:21 INFO - '--tppagecycles', 17:22:21 INFO - '7'], 17:22:21 INFO - 'tests': ['tsvgm']}}, 17:22:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:22:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:22:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:22:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:22:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:22:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['damp', 'tps']}, 17:22:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'tests': ['damp', 'tps']}, 17:22:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['dromaeo_dom']}, 17:22:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:22:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['a11yr', 17:22:21 INFO - 'ts_paint', 17:22:21 INFO - 'tpaint', 17:22:21 INFO - 'sessionrestore', 17:22:21 INFO - 'sessionrestore_no_auto_restore', 17:22:21 INFO - 'tabpaint']}, 17:22:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['tsvgx', 17:22:21 INFO - 'tsvgr_opacity', 17:22:21 INFO - 'tart', 17:22:21 INFO - 'tscrollx', 17:22:21 INFO - 'cart']}, 17:22:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:22:21 INFO - 'tsvgr_opacity', 17:22:21 INFO - 'tart', 17:22:21 INFO - 'tscrollx', 17:22:21 INFO - 'cart']}, 17:22:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'talos_options': ['--disable-e10s'], 17:22:21 INFO - 'tests': ['tp5o']}, 17:22:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'tests': ['tp5o']}, 17:22:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'talos_options': ['--disable-e10s', 17:22:21 INFO - '--xperf_path', 17:22:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:21 INFO - 'tests': ['tp5n']}, 17:22:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:22:21 INFO - 'talos_options': ['--xperf_path', 17:22:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:22:21 INFO - 'tests': ['tp5n']}}, 17:22:21 INFO - 'talos.zip': {'path': '', 17:22:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:22:21 INFO - Running post-action listener: _resource_record_post_action 17:22:21 INFO - ##### 17:22:21 INFO - ##### Finished populate-webroot step (success) 17:22:21 INFO - ##### 17:22:21 INFO - ##### 17:22:21 INFO - ##### Running create-virtualenv step. 17:22:21 INFO - ##### 17:22:21 INFO - Running pre-action listener: _resource_record_pre_action 17:22:21 INFO - Running main action method: create_virtualenv 17:22:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:22:21 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 17:22:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:22:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:22:21 INFO - Using real prefix '/usr' 17:22:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:22:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:22:24 INFO - Installing pip.................done. 17:22:24 INFO - Return code: 0 17:22:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:22:24 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')]} 17:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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')]} 17:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:24 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 17:22:24 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 17:22:24 INFO - Using env: {'DISPLAY': ':0', 17:22:24 INFO - 'HOME': '/home/cltbld', 17:22:24 INFO - 'LANG': 'en_US.UTF-8', 17:22:24 INFO - 'LANGUAGE': 'en_US:en', 17:22:24 INFO - 'LOGNAME': 'cltbld', 17:22:24 INFO - 'MAIL': '/var/mail/cltbld', 17:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:24 INFO - 'MOZ_NO_REMOTE': '1', 17:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:24 INFO - 'NO_EM_RESTART': '1', 17:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:24 INFO - 'PWD': '/builds/slave/test', 17:22:24 INFO - 'SHELL': '/bin/bash', 17:22:24 INFO - 'SHLVL': '1', 17:22:24 INFO - 'TERM': 'linux', 17:22:24 INFO - 'TMOUT': '86400', 17:22:24 INFO - 'USER': 'cltbld', 17:22:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:24 INFO - '_': '/tools/buildbot/bin/python'} 17:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:24 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 17:22:24 INFO - Cleaning up... 17:22:24 INFO - Return code: 0 17:22:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:22:24 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')]} 17:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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')]} 17:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:24 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:24 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 17:22:24 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 17:22:24 INFO - Using env: {'DISPLAY': ':0', 17:22:24 INFO - 'HOME': '/home/cltbld', 17:22:24 INFO - 'LANG': 'en_US.UTF-8', 17:22:24 INFO - 'LANGUAGE': 'en_US:en', 17:22:24 INFO - 'LOGNAME': 'cltbld', 17:22:24 INFO - 'MAIL': '/var/mail/cltbld', 17:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:24 INFO - 'MOZ_NO_REMOTE': '1', 17:22:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:24 INFO - 'NO_EM_RESTART': '1', 17:22:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:24 INFO - 'PWD': '/builds/slave/test', 17:22:24 INFO - 'SHELL': '/bin/bash', 17:22:24 INFO - 'SHLVL': '1', 17:22:24 INFO - 'TERM': 'linux', 17:22:24 INFO - 'TMOUT': '86400', 17:22:24 INFO - 'USER': 'cltbld', 17:22:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:24 INFO - '_': '/tools/buildbot/bin/python'} 17:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:24 INFO - Downloading/unpacking psutil>=3.1.1 17:22:24 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 17:22:24 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 17:22:24 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 17:22:24 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 17:22:24 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 17:22:24 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 17:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:22:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:26 INFO - Installing collected packages: psutil 17:22:26 INFO - Running setup.py install for psutil 17:22:26 INFO - building 'psutil._psutil_linux' extension 17:22:26 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 17:22:26 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 17:22:26 INFO - building 'psutil._psutil_posix' extension 17:22:26 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 17:22:27 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 17:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:22:27 INFO - Successfully installed psutil 17:22:27 INFO - Cleaning up... 17:22:27 INFO - Return code: 0 17:22:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:22:27 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')]} 17:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:27 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')]} 17:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:27 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:27 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 17:22:27 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 17:22:27 INFO - Using env: {'DISPLAY': ':0', 17:22:27 INFO - 'HOME': '/home/cltbld', 17:22:27 INFO - 'LANG': 'en_US.UTF-8', 17:22:27 INFO - 'LANGUAGE': 'en_US:en', 17:22:27 INFO - 'LOGNAME': 'cltbld', 17:22:27 INFO - 'MAIL': '/var/mail/cltbld', 17:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:27 INFO - 'MOZ_NO_REMOTE': '1', 17:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:27 INFO - 'NO_EM_RESTART': '1', 17:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:27 INFO - 'PWD': '/builds/slave/test', 17:22:27 INFO - 'SHELL': '/bin/bash', 17:22:27 INFO - 'SHLVL': '1', 17:22:27 INFO - 'TERM': 'linux', 17:22:27 INFO - 'TMOUT': '86400', 17:22:27 INFO - 'USER': 'cltbld', 17:22:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:27 INFO - '_': '/tools/buildbot/bin/python'} 17:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:27 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 17:22:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:22:29 INFO - Installing collected packages: mozsystemmonitor 17:22:29 INFO - Running setup.py install for mozsystemmonitor 17:22:29 INFO - Successfully installed mozsystemmonitor 17:22:29 INFO - Cleaning up... 17:22:29 INFO - Return code: 0 17:22:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:29 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:29 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 17:22:29 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 17:22:29 INFO - Using env: {'DISPLAY': ':0', 17:22:29 INFO - 'HOME': '/home/cltbld', 17:22:29 INFO - 'LANG': 'en_US.UTF-8', 17:22:29 INFO - 'LANGUAGE': 'en_US:en', 17:22:29 INFO - 'LOGNAME': 'cltbld', 17:22:29 INFO - 'MAIL': '/var/mail/cltbld', 17:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:29 INFO - 'MOZ_NO_REMOTE': '1', 17:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:29 INFO - 'NO_EM_RESTART': '1', 17:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:29 INFO - 'PWD': '/builds/slave/test', 17:22:29 INFO - 'SHELL': '/bin/bash', 17:22:29 INFO - 'SHLVL': '1', 17:22:29 INFO - 'TERM': 'linux', 17:22:29 INFO - 'TMOUT': '86400', 17:22:29 INFO - 'USER': 'cltbld', 17:22:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:29 INFO - '_': '/tools/buildbot/bin/python'} 17:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:22:29 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 17:22:29 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 17:22:29 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 17:22:29 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 17:22:29 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 17:22:29 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 17:22:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:22:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:22:31 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 17:22:31 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 17:22:31 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 17:22:31 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 17:22:31 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 17:22:31 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 17:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:22:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:22:32 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 17:22:32 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 17:22:32 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 17:22:32 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 17:22:32 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 17:22:32 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 17:22:32 INFO - Downloading docopt-0.6.1.tar.gz 17:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:22:32 INFO - Installing collected packages: blobuploader, requests, docopt 17:22:32 INFO - Running setup.py install for blobuploader 17:22:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:22:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:22:32 INFO - Running setup.py install for requests 17:22:32 INFO - Running setup.py install for docopt 17:22:33 INFO - Successfully installed blobuploader requests docopt 17:22:33 INFO - Cleaning up... 17:22:33 INFO - Return code: 0 17:22:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:33 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')]} 17:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:33 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')]} 17:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:33 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:33 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 17:22:33 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 17:22:33 INFO - Using env: {'DISPLAY': ':0', 17:22:33 INFO - 'HOME': '/home/cltbld', 17:22:33 INFO - 'LANG': 'en_US.UTF-8', 17:22:33 INFO - 'LANGUAGE': 'en_US:en', 17:22:33 INFO - 'LOGNAME': 'cltbld', 17:22:33 INFO - 'MAIL': '/var/mail/cltbld', 17:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:33 INFO - 'MOZ_NO_REMOTE': '1', 17:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:33 INFO - 'NO_EM_RESTART': '1', 17:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:33 INFO - 'PWD': '/builds/slave/test', 17:22:33 INFO - 'SHELL': '/bin/bash', 17:22:33 INFO - 'SHLVL': '1', 17:22:33 INFO - 'TERM': 'linux', 17:22:33 INFO - 'TMOUT': '86400', 17:22:33 INFO - 'USER': 'cltbld', 17:22:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:33 INFO - '_': '/tools/buildbot/bin/python'} 17:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:33 INFO - Running setup.py (path:/tmp/pip-rS8q_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:33 INFO - Running setup.py (path:/tmp/pip-NNXRbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:33 INFO - Running setup.py (path:/tmp/pip-Sus9Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:33 INFO - Running setup.py (path:/tmp/pip-oRTUgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:33 INFO - Running setup.py (path:/tmp/pip-w91mY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:33 INFO - Running setup.py (path:/tmp/pip-nXcQG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:33 INFO - Running setup.py (path:/tmp/pip-C2dUn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:33 INFO - Running setup.py (path:/tmp/pip-nt1TFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:33 INFO - Running setup.py (path:/tmp/pip-SPpMid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:33 INFO - Running setup.py (path:/tmp/pip-JzWvBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:34 INFO - Running setup.py (path:/tmp/pip-oLg7jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:34 INFO - Running setup.py (path:/tmp/pip-nyxuSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:34 INFO - Running setup.py (path:/tmp/pip-qdny53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:34 INFO - Running setup.py (path:/tmp/pip-3tKXbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:34 INFO - Running setup.py (path:/tmp/pip-lbc4a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:34 INFO - Running setup.py (path:/tmp/pip-99k6eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:34 INFO - Running setup.py (path:/tmp/pip-AjQqcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:22:34 INFO - Running setup.py install for manifestparser 17:22:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for mozcrash 17:22:34 INFO - Running setup.py install for mozdebug 17:22:34 INFO - Running setup.py install for mozdevice 17:22:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:22:34 INFO - Running setup.py install for mozfile 17:22:35 INFO - Running setup.py install for mozhttpd 17:22:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozinfo 17:22:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozInstall 17:22:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozleak 17:22:35 INFO - Running setup.py install for mozlog 17:22:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for moznetwork 17:22:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozprocess 17:22:35 INFO - Running setup.py install for mozprofile 17:22:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozrunner 17:22:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:22:35 INFO - Running setup.py install for mozscreenshot 17:22:36 INFO - Running setup.py install for moztest 17:22:36 INFO - Running setup.py install for mozversion 17:22:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:22:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:22:36 INFO - Cleaning up... 17:22:36 INFO - Return code: 0 17:22:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:36 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:36 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 17:22:36 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 17:22:36 INFO - Using env: {'DISPLAY': ':0', 17:22:36 INFO - 'HOME': '/home/cltbld', 17:22:36 INFO - 'LANG': 'en_US.UTF-8', 17:22:36 INFO - 'LANGUAGE': 'en_US:en', 17:22:36 INFO - 'LOGNAME': 'cltbld', 17:22:36 INFO - 'MAIL': '/var/mail/cltbld', 17:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:36 INFO - 'MOZ_NO_REMOTE': '1', 17:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:36 INFO - 'NO_EM_RESTART': '1', 17:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:36 INFO - 'PWD': '/builds/slave/test', 17:22:36 INFO - 'SHELL': '/bin/bash', 17:22:36 INFO - 'SHLVL': '1', 17:22:36 INFO - 'TERM': 'linux', 17:22:36 INFO - 'TMOUT': '86400', 17:22:36 INFO - 'USER': 'cltbld', 17:22:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:36 INFO - '_': '/tools/buildbot/bin/python'} 17:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:22:36 INFO - Running setup.py (path:/tmp/pip-09mHMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:22:36 INFO - Running setup.py (path:/tmp/pip-ZPlgSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:22:36 INFO - Running setup.py (path:/tmp/pip-z6NWiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:22:36 INFO - Running setup.py (path:/tmp/pip-9TX_Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:22:36 INFO - Running setup.py (path:/tmp/pip-JMizCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:22:36 INFO - Running setup.py (path:/tmp/pip-qectOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:22:36 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)) 17:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:22:36 INFO - Running setup.py (path:/tmp/pip-QvfWMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:22:37 INFO - Running setup.py (path:/tmp/pip-LWnrfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:22:37 INFO - Running setup.py (path:/tmp/pip-bJ0P53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:22:37 INFO - Running setup.py (path:/tmp/pip-6G9Oa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:22:37 INFO - Running setup.py (path:/tmp/pip-Ki4JvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:22:37 INFO - Running setup.py (path:/tmp/pip-g6lMEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:22:37 INFO - Running setup.py (path:/tmp/pip-emNlak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:22:37 INFO - Running setup.py (path:/tmp/pip-QC5YWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:37 INFO - Running setup.py (path:/tmp/pip-EJ6ob7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:22:37 INFO - Running setup.py (path:/tmp/pip-KcVXs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:22:37 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)) 17:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:22:37 INFO - Running setup.py (path:/tmp/pip-zZzvI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:22:37 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)) 17:22:37 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)) 17:22:37 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)) 17:22:37 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)) 17:22:37 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)) 17:22:37 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)) 17:22:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:39 INFO - Downloading blessings-1.6.tar.gz 17:22:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:22:39 INFO - Installing collected packages: blessings 17:22:39 INFO - Running setup.py install for blessings 17:22:39 INFO - Successfully installed blessings 17:22:39 INFO - Cleaning up... 17:22:39 INFO - Return code: 0 17:22:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:40 INFO - Reading from file tmpfile_stdout 17:22:40 INFO - Current package versions: 17:22:40 INFO - argparse == 1.2.1 17:22:40 INFO - blessings == 1.6 17:22:40 INFO - blobuploader == 1.2.4 17:22:40 INFO - docopt == 0.6.1 17:22:40 INFO - manifestparser == 1.1 17:22:40 INFO - mozInstall == 1.12 17:22:40 INFO - mozcrash == 0.17 17:22:40 INFO - mozdebug == 0.1 17:22:40 INFO - mozdevice == 0.48 17:22:40 INFO - mozfile == 1.2 17:22:40 INFO - mozhttpd == 0.7 17:22:40 INFO - mozinfo == 0.9 17:22:40 INFO - mozleak == 0.1 17:22:40 INFO - mozlog == 3.2 17:22:40 INFO - moznetwork == 0.27 17:22:40 INFO - mozprocess == 0.22 17:22:40 INFO - mozprofile == 0.28 17:22:40 INFO - mozrunner == 6.11 17:22:40 INFO - mozscreenshot == 0.1 17:22:40 INFO - mozsystemmonitor == 0.3 17:22:40 INFO - moztest == 0.7 17:22:40 INFO - mozversion == 1.4 17:22:40 INFO - psutil == 3.1.1 17:22:40 INFO - requests == 1.2.3 17:22:40 INFO - wsgiref == 0.1.2 17:22:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:22:40 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')]} 17:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:40 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')]} 17:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:40 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:40 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 17:22:40 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 17:22:40 INFO - Using env: {'DISPLAY': ':0', 17:22:40 INFO - 'HOME': '/home/cltbld', 17:22:40 INFO - 'LANG': 'en_US.UTF-8', 17:22:40 INFO - 'LANGUAGE': 'en_US:en', 17:22:40 INFO - 'LOGNAME': 'cltbld', 17:22:40 INFO - 'MAIL': '/var/mail/cltbld', 17:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:40 INFO - 'MOZ_NO_REMOTE': '1', 17:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:40 INFO - 'NO_EM_RESTART': '1', 17:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:40 INFO - 'PWD': '/builds/slave/test', 17:22:40 INFO - 'SHELL': '/bin/bash', 17:22:40 INFO - 'SHLVL': '1', 17:22:40 INFO - 'TERM': 'linux', 17:22:40 INFO - 'TMOUT': '86400', 17:22:40 INFO - 'USER': 'cltbld', 17:22:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:40 INFO - '_': '/tools/buildbot/bin/python'} 17:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 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)) 17:22:40 INFO - Cleaning up... 17:22:40 INFO - Return code: 0 17:22:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:22:40 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')]} 17:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:40 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')]} 17:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:40 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 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:40 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 17:22:40 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 17:22:40 INFO - Using env: {'DISPLAY': ':0', 17:22:40 INFO - 'HOME': '/home/cltbld', 17:22:40 INFO - 'LANG': 'en_US.UTF-8', 17:22:40 INFO - 'LANGUAGE': 'en_US:en', 17:22:40 INFO - 'LOGNAME': 'cltbld', 17:22:40 INFO - 'MAIL': '/var/mail/cltbld', 17:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:40 INFO - 'MOZ_NO_REMOTE': '1', 17:22:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:40 INFO - 'NO_EM_RESTART': '1', 17:22:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:40 INFO - 'PWD': '/builds/slave/test', 17:22:40 INFO - 'SHELL': '/bin/bash', 17:22:40 INFO - 'SHLVL': '1', 17:22:40 INFO - 'TERM': 'linux', 17:22:40 INFO - 'TMOUT': '86400', 17:22:40 INFO - 'USER': 'cltbld', 17:22:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:40 INFO - '_': '/tools/buildbot/bin/python'} 17:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:40 INFO - Downloading/unpacking jsonschema 17:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:22:42 INFO - Downloading/unpacking functools32 (from jsonschema) 17:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:22:42 INFO - warning: no files found matching '*.txt' 17:22:42 INFO - no previously-included directories found matching 'build' 17:22:42 INFO - no previously-included directories found matching 'dist' 17:22:42 INFO - no previously-included directories found matching '.git*' 17:22:42 INFO - Installing collected packages: jsonschema, functools32 17:22:42 INFO - Running setup.py install for functools32 17:22:42 INFO - warning: no files found matching '*.txt' 17:22:42 INFO - no previously-included directories found matching 'build' 17:22:42 INFO - no previously-included directories found matching 'dist' 17:22:42 INFO - no previously-included directories found matching '.git*' 17:22:42 INFO - Successfully installed jsonschema functools32 17:22:42 INFO - Cleaning up... 17:22:42 INFO - Return code: 0 17:22:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f707d521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, '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': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', '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 17:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:22:42 INFO - Using env: {'DISPLAY': ':0', 17:22:42 INFO - 'HOME': '/home/cltbld', 17:22:42 INFO - 'LANG': 'en_US.UTF-8', 17:22:42 INFO - 'LANGUAGE': 'en_US:en', 17:22:42 INFO - 'LOGNAME': 'cltbld', 17:22:42 INFO - 'MAIL': '/var/mail/cltbld', 17:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:42 INFO - 'MOZ_NO_REMOTE': '1', 17:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:42 INFO - 'NO_EM_RESTART': '1', 17:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:42 INFO - 'PWD': '/builds/slave/test', 17:22:42 INFO - 'SHELL': '/bin/bash', 17:22:42 INFO - 'SHLVL': '1', 17:22:42 INFO - 'TERM': 'linux', 17:22:42 INFO - 'TMOUT': '86400', 17:22:42 INFO - 'USER': 'cltbld', 17:22:42 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:42 INFO - '_': '/tools/buildbot/bin/python'} 17:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:22:43 INFO - Downloading/unpacking flake8 17:22:43 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 17:22:43 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 17:22:43 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 17:22:43 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 17:22:43 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 17:22:43 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 17:22:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:22:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:22:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:22:45 INFO - no previously-included directories found matching 'docs/_build' 17:22:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:22:45 INFO - Running setup.py install for pep8 17:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:22:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:22:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:22:45 INFO - no previously-included directories found matching 'docs/_build' 17:22:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:22:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:22:45 INFO - Cleaning up... 17:22:46 INFO - Return code: 0 17:22:46 INFO - Running post-action listener: _resource_record_post_action 17:22:46 INFO - Running post-action listener: _start_resource_monitoring 17:22:46 INFO - Starting resource monitoring. 17:22:46 INFO - ##### 17:22:46 INFO - ##### Finished create-virtualenv step (success) 17:22:46 INFO - ##### 17:22:46 INFO - ##### 17:22:46 INFO - ##### Running install step. 17:22:46 INFO - ##### 17:22:46 INFO - Running pre-action listener: _resource_record_pre_action 17:22:46 INFO - Running main action method: install 17:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:22:46 INFO - Reading from file tmpfile_stdout 17:22:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:22:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:22:46 INFO - Reading from file tmpfile_stdout 17:22:46 INFO - Output received: 17:22:46 INFO - Usage: mozinstall [options] installer 17:22:46 INFO - Options: 17:22:46 INFO - -h, --help show this help message and exit 17:22:46 INFO - -d DEST, --destination=DEST 17:22:46 INFO - Directory to install application into. [default: 17:22:46 INFO - "/builds/slave/test"] 17:22:46 INFO - --app=APP Application being installed. [default: firefox] 17:22:46 INFO - mkdir: /builds/slave/test/build/application 17:22:46 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'] 17:22:46 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 17:23:02 INFO - Reading from file tmpfile_stdout 17:23:02 INFO - Output received: 17:23:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:23:02 INFO - Running post-action listener: _resource_record_post_action 17:23:02 INFO - ##### 17:23:02 INFO - ##### Finished install step (success) 17:23:02 INFO - ##### 17:23:02 INFO - ##### 17:23:02 INFO - ##### Running run-tests step. 17:23:02 INFO - ##### 17:23:02 INFO - Running pre-action listener: _resource_record_pre_action 17:23:02 INFO - Running main action method: run_tests 17:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:23:02 INFO - Python 2.7.3 17:23:02 INFO - Return code: 0 17:23:02 INFO - grabbing minidump binary from tooltool 17:23:02 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')]} 17:23:02 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 0x26dd9c0>, '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 0x26de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ded50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:23:02 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 17:23:02 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 17:23:02 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 17:23:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:23:03 INFO - Return code: 0 17:23:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:23:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:23:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:23:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:23:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:23:03 INFO - Return code: 0 17:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 17:23:03 INFO - Using env: {'DISPLAY': ':0', 17:23:03 INFO - 'HOME': '/home/cltbld', 17:23:03 INFO - 'LANG': 'en_US.UTF-8', 17:23:03 INFO - 'LANGUAGE': 'en_US:en', 17:23:03 INFO - 'LOGNAME': 'cltbld', 17:23:03 INFO - 'MAIL': '/var/mail/cltbld', 17:23:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:23:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:23:03 INFO - 'MOZ_NO_REMOTE': '1', 17:23:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:23:03 INFO - 'NO_EM_RESTART': '1', 17:23:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:23:03 INFO - 'PWD': '/builds/slave/test', 17:23:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:23:03 INFO - 'SHELL': '/bin/bash', 17:23:03 INFO - 'SHLVL': '1', 17:23:03 INFO - 'TERM': 'linux', 17:23:03 INFO - 'TMOUT': '86400', 17:23:03 INFO - 'USER': 'cltbld', 17:23:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000', 17:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:23:03 INFO - '_': '/tools/buildbot/bin/python'} 17:23:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 17:23:04 INFO - mozversion application_buildid: 20160516143016 17:23:04 INFO - mozversion application_changeset: ae689711c21875e2f732c97264e35527c7f6b963 17:23:04 INFO - mozversion application_display_name: Nightly 17:23:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:23:04 INFO - mozversion application_name: Firefox 17:23:04 INFO - mozversion application_remotingname: firefox 17:23:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:23:04 INFO - mozversion application_vendor: Mozilla 17:23:04 INFO - mozversion application_version: 49.0a1 17:23:04 INFO - mozversion platform_buildid: 20160516143016 17:23:04 INFO - mozversion platform_changeset: ae689711c21875e2f732c97264e35527c7f6b963 17:23:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:23:04 INFO - mozversion platform_version: 49.0a1 17:23:04 INFO - using testdate: 1463444584 17:23:04 INFO - actual date: 1463444584 17:23:04 INFO - starting webserver on 'localhost:34443' 17:23:04 INFO - SUITE-START | Running 2 tests 17:23:04 INFO - TEST-START | dromaeo_css 17:23:04 INFO - operating with platform_type : linux_ 17:23:04 INFO - Initialising browser for dromaeo_css test... 17:23:04 INFO - TEST-INFO | started process 21060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCaHKV/profile http://localhost:34443/getInfo.html) 17:23:08 INFO - PROCESS | 21060 | __metrics Screen width/height:1600/1200 17:23:08 INFO - PROCESS | 21060 | colorDepth:24 17:23:08 INFO - PROCESS | 21060 | Browser inner width/height: 1024/697 17:23:08 INFO - PROCESS | 21060 | __metrics 17:23:09 ERROR - PROCESS | 21060 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:23:10 INFO - TEST-INFO | 21060: exit 0 17:23:10 INFO - Browser initialized. 17:23:10 INFO - Running cycle 1/1 for dromaeo_css test... 17:23:10 INFO - TEST-INFO | started process 21143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCaHKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:21 INFO - PROCESS | 21143 | RSS: Main: 152645632 17:23:21 INFO - PROCESS | 21143 | 17:24:13 INFO - PROCESS | 21143 | 1463444653174 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] 17:26:21 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34443/tests/dromaeo/cssquery-ext.html) 17:26:22 INFO - PROCESS | 21143 | RSS: Main: 253227008 17:26:22 INFO - PROCESS | 21143 | 17:29:24 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-ext.html (next: http://localhost:34443/tests/dromaeo/cssquery-jquery.html) 17:29:25 INFO - PROCESS | 21143 | RSS: Main: 240218112 17:29:25 INFO - PROCESS | 21143 | 17:32:26 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34443/tests/dromaeo/cssquery-mootools.html) 17:32:27 INFO - PROCESS | 21143 | RSS: Main: 240926720 17:32:27 INFO - PROCESS | 21143 | 17:35:29 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34443/tests/dromaeo/cssquery-prototype.html) 17:35:29 INFO - PROCESS | 21143 | RSS: Main: 234557440 17:35:29 INFO - PROCESS | 21143 | 17:38:32 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34443/tests/dromaeo/cssquery-yui.html) 17:38:33 INFO - PROCESS | 21143 | RSS: Main: 221855744 17:38:33 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | Cycle 1(1): loaded http://localhost:34443/tests/dromaeo/cssquery-yui.html (next: http://localhost:34443/tests/dromaeo/cssquery-dojo.html) 17:41:35 INFO - PROCESS | 21143 | RSS: Main: 260722688 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | __start_tp_report 17:41:35 INFO - PROCESS | 21143 | _x_x_mozilla_page_load 17:41:35 INFO - PROCESS | 21143 | _x_x_mozilla_page_load_details 17:41:35 INFO - PROCESS | 21143 | |i|pagename|runs| 17:41:35 INFO - PROCESS | 21143 | |0;dojo.html;3101.3487167694784;3140.057982605218;3170.4451720948828;3205.759568032398;3248.1230067881675;5250.65870718403;5314.335708036496;5316.149416093426;5420.403755586883;5436.429174936629;5347.812826551071;5358.3569971603465;5359.758810853511;5363.731813409324;5395.676259424427;4833.419989601252;4840.346553215306;5004.499550044985;5056.494350564951;5092.643514953955;4972.825951091712;4975.378077740283;5010.974945125269;5029.924551131736;5041.495850414965;4776.641751868607;4836.443808961944;4840.878978025542;4845.612351011928;4874.171390863562;4835.323054772335;4851.514848515156;4880.097182021337;4885.267209918505;4939;4855.44162421319;4880.097182021302;4899.191633380488;4903.117438861003;4956.826511072131;5166.560842328407;5211.478852114796;5239.764210610531;5243.475652434726;5311.389190243133;5652;5683.630564013367;5759.827205183851;5784.595078344518;5784.623999440023;5642.210090587321;5772.48047675707;5814.709264536798;5815.709214539298;5820.476157145878;5334.893302133974;5379.300690910196;5417.566594672417;5463.754131064112;5466.01611709888;5902.557308201902;5910.911336329958;5916.792912248051;5967.522598192134;5967.910481342783;5544.667319960815;5647.802326918621;5740.655560666373;5742.7415766290615;5751.971240143856;5754.597178197486;5788.421157884178;5791.942080579224;5797.275340582427;5850.444207800252;5719.971400142973;5780.479756821906;5795.362510123968;5796;5796.1595568642315;5524.14375771756;5604.495595396434;5644.8306550803545;5782.045962416239;5784.537237021028;4322;4324.200022995756;4328.978355108205;4364.978175109104;4368.694191406571;3857.517810273716;3860.729748917605;3873.5351757789244;3888.0862997195636;3910.2961466936226;5224.164133738584;5340.06548853949;5359.437259087817;5389.865253368697;5456.61803673747;5779.190913272145;5814.418558144152;5841.912371314434;5845.678487683133;5886.264216972879;5444.40111587725;5463.262459567907;5466.262054622654;5468;5469.453054694499;4807.543283388072;4922.532359425849;4962.354893863775;4977.726225057657;5001.074801161797;5959.314678811906;6002.219711437485;6011;6018;6021.638701677825;5669.659820410789;5853.2976042875125;5871.972404829223;5875.41245875409;5878.382769809108;5861.824145275648;5938.990371636745;5951.791687290924;5985.281766188085;5985.790497332572;5702.657840529581;5705.629134106436;5709.628874123168;5710.057840456278;5732.3121225453215;5632.577556683347;5714.771409143587;5780.537556995514;5838.503727183067;5840.415958404125;5530.695811730394;5555.916661250165;5557.805476808292;5559.11054231321;5611.859703507445;5545.306836645419;5551.528120109674;5555.2778138841695;5559.805406810904;5565.30433695788;5290.074237008585;5396.811111611075;5398.757055932414;5441.646292990943;5514.503694667499;5573.3869274380595;5603.355614104267;5638.4925356718095;5643.943560564342;5644.040513112698;5483.479069488392;5490.533304669148;5494.203340515683;5495.945040549544;5549.195366671891 17:41:35 INFO - PROCESS | 21143 | |1;ext.html;603.8762053778976;638.2723694987714;639.2265358915712;650.2327253840468;656.0094257670916;34024.82987585061;36989.44515832265;37038.62961370385;43385.78307108468;44806;48139.27791083136;48307.75846120773;48514.27228591574;48609;48698.75650621742;9064.682736104238;9203.953980230122;9220.492872891988;9239.815203695922;9243.49160796156;9022.368434209575;9090.54547272637;9132.086791320848;9143;9145.268378529701;9149.95425022874;9176.311776616747;9200.585973631169;9223;9225.12361325673;9105.499197544132;9125.817483650357;9157.496337701425;9158.084191580821;9158.313126515472;9084.091590840862;9149.679761208392;9158.221551168092;9167.358284920057;9172.724818255396;43683.563164368265;43981;44037.33943990843;44084.338734919;44093.559064409266;3562.71498280137;4083.8774836754646;4189.371594260855;4221.2190744712325;4357.542458041923;33089.50365744516;33142.834285828656;33345.49981750276;33349.16627084318;34808.825955870314;4387.802548885308;4399.23013472641;4400.691951563392;4517.593416592523;4601.562851529099;358688;359692;359833;360394;360614;36859.447108293396;37941.62058379381;37945.24109517794;39642.80178599089;61757.382426175165;39253.60746392557;39410.21179576393;39490.80254598766;39605.40591891124;39609.80195099064;15169.24153792306;15224.619384515476;15304.158271295186;15315.46395876139;15323.080615163126;12393;12451.688707782378;12468.5012599495;12494;12622.368881555885;8885.511296878605;8898.243649289883;8901.910980890238;8959.776005599782;8984.820303593891;3354;3369.983150084234;3407.9488807667904;3437.5187473753695;3482.1294676330917;1022.882368527614;1045.9372437653765;1049.511976930731;1059.8092343378112;1071.7534966957644;32945.505817412755;33411.3317733644;33540;33761;34109.48835767466;1052.8420736889527;1116.843641890136;1131.372088490879;1169.3568537304448;1179.6814859987926;17537;17599.20803563843;17766.644667106586;17864.55338616519;17968.9101554494;562625;562741;566281;567885;568894;59917.40082599118;61236;61245.69377153175;61273.38726612766;61389;1305.1842598376015;1391.756442622537;1425.6435891027243;1440.1862947434665;1444.4294503671201;33323.00123985137;34615.653843461245;34848.82575587207;34942.12644683903;35047.12382190466;51105.488945110075;51573.48426515687;51933.48066519287;51951.48048519466;52192;419669;420839;421018;421733;424672;25951.351216219744;28628.997985070422;29101.417971640873;29264.122076337742;29356.853215733783;49345.753271233414;49629.50370496249;50006.249906250705;50250.24624630706;50728.74635626946;42129.78935105305;42820.357694635226;43164.352534712634;44169.77915110532;44538;42565.57434425616;42566;42958.57041429671;43101;43663;41262;41844;42167.789161053995;42883.7855810719;42903.35644965265;36660.45009324809;37820;38194.42708359321;38504.422433662956;38641;28585;28994.855025724737;29076.27309317284;29098.6810207493;29254.7074529252 17:41:35 INFO - PROCESS | 21143 | |2;jquery.html;387.61625990269624;387.6549870615155;395.44440061713266;397.76531846210736;411.77146683590615;17978.640427191447;19529.316473923398;19591.608167836654;19648.21407143716;20500.589988200227;19015.144318505667;19206.615867682674;19708.310209142684;19872.205111795545;20097.899510502462;5591.496765291123;5744.712764361797;5844;5900.527957763368;5901.911471327933;5778.59549831512;5808.12878068289;5811.360750317462;5825.8834823303505;5829.125631155318;5621.4940655341015;5744.16709577111;5763.279590051244;5832.504237139849;5836.474717275444;5657.519110875581;5702.600817942745;5705.659170095024;5731.971340143315;5736.512396446286;5090.796368145269;5201.609879259071;5218.347706536683;5225.268462415265;5229.529342359206;19798.208071677116;20683.793162068338;23423.180188693314;23677.408064798346;23957.281281561405;2428.647846062329;2445.058652418814;2470.72821989581;2490.3649569359877;3049.1919641295076;10060.295779295378;10766.730831729192;13585.184888906599;13980.510682126076;14977.550673479813;1985.1662301833264;2003.5592169722638;2053.435305291042;2063.380985704283;2108.0303060592146;83107.58446207791;83788;86587.56706216492;86840;88200;11337.829932551018;11373.431328433546;11571.942140289244;11645;11887.227330223508;16221.432249871197;16280.511584652479;16387.672246555;16411.261493232832;16421.83578164227;8092.3121534669035;8260.628271727786;8386.958065209636;8458.069612342637;8537.573121343908;7692.807679808049;7845.646945887449;7878.330341920886;7888.329491993245;8031.83936321282;4794.568488836021;4975.4527002029745;5028.120078986163;5089.3638295213095;5141.177411614199;2022.3023057045295;2027.5438026443933;2051.938441846747;2054.8356131509445;2078.1271865816093;923.5474617437408;946.1484663802632;1014.7463134216446;1040.7086015915556;1073.5061871539024;19035.714464283046;19625.411237662895;19854.503637408892;20074.698879516818;20077.899610502147;987.3039507147587;1000.049952545085;1014.8680671512656;1040.890706475809;1057.376148072641;10715.410652414192;11227.214095013434;11268;11276.1542884284;11358.26171298863;462613;462852;466389;469134;500120;72814.63592682108;84246.57876710578;89473;95198.52400737951;97445;1027.6403258859489;1035.2442716816765;1047.554789214596;1068.1935138970027;1069.4332004037717;17877.821221787617;17962.730559041887;18180.909095454437;18311.084445777924;18646.160922758238;40965.38551921664;41590.1681966365;41866.37200441935;42119.789401054026;42915.14169716651;58516.70741646265;58569.70715146397;61241.38758612535;62431.6878415605;63182;8762.561871906506;8830.867536986822;9013.278937684838;9040.321975851706;9129.178373946377;13610.319484025562;13827;13899.583012509642;13940.721185576029;14001.719965600834;6149.2620885494025;9056.547172641473;9404.777378940695;11254.268472549258;11297.813729558608;11709.355985420883;11715.824262635897;11826.763464730486;11965.162438629213;12161.39193040362;11916.344601047025;11998.880011200126;12065.396730163633;12132.75734485323;12144.089193310714;8632.61153248118;8658.696945607126;8796.560171991503;8992.100789920956;9188.173064424234;11865.5847045353;12405.937970310091;12513.436895339913;12528.37358132108;12547.372631368578 17:41:35 INFO - PROCESS | 21143 | |3;mootools.html;1373.7870630052332;1533.5782659768565;1549.4112237349807;1688.7466879968003;1869.5886904880922;8602.311815054796;8931.37480376374;8989.640414383424;9162.679306224283;9185.678501252458;9047.321450891177;9255.352125351228;9265.583048762805;9267.953660231706;9268.165865072142;2380.5952987991996;2405.867677277749;2406.1578447543393;2410.95178096438;2411.1078900806638;2368.017272831773;2392.3181893160454;2417.9516409671796;2422.152246713645;2429.2955043037496;2362.397588614901;2365.302235840423;2385.117506522589;2396.688430504032;2399.6040653292184;2256.1426657869906;2320.918767843126;2341.800946919514;2347.8239132065078;2354.705661792276;2243.618584840581;2308.145985985196;2308.249818808877;2308.5382923415386;2310.4801419680607;7632.923670763277;8744.256738177262;9337.906620933773;9394.812103757886;9401.529923503798;5064.645474816764;5314.4951229633125;5325.920111198335;5333.120035194227;5349.812756553502;3369.9157521061925;3382.0530251529367;3442.535257740198;3474.0099071764425;3476.0788391076385;1144.5364627325946;1145.2441388683428;1145.410113791398;1146.5012719467059;1178.381349791358;13448.663783405394;13559.796603050961;13581.796273055912;13585.456581736718;13611.795823062663;4626.629869610423;4682.6253899687945;4720.45714742809;4778.856634300907;4794.496577859344;11403.030742386823;11420.086393088533;11422.485988130555;11427.60003399877;11431.828522572001;5305.867353316121;5357.892842143136;5358.490943360374;5366.973165134149;5379.731013449312;4875.756212189376;4924.532169443969;5010.398752149693;5020.523050310215;5056.241563765391;4026.5570787213383;4054.3107671695884;4058.898527536835;4100.159467309194;4139.586041395836;1163.8952494275557;1174.7591743692522;1175.4375461493855;1175.6825657072543;1223.0215827338093;851.6465666748354;873.323174539724;924.8797656304637;992.6823416506649;995.6664517386612;5998.880022399528;6061.757529698851;6067.24159480065;6172.444479996732;6207.162033125561;432.9783510824446;434.19240213203415;439.0494579235982;450.0234491154203;454.59995204220735;4064;4151.750894946313;4152.231837110084;4156.56356082613;4166.708330416903;11002.779944401067;11081.833772493419;11107.222494425312;11122.61070862516;11130.443477826077;11084.279521831055;11114.499847506882;11138.443077846237;11147.052500537546;11161.441927903572;7886.487378320391;8211.21993410625;8242.2581967622;8499.787505312293;8582.570871456403;5639.943600564106;5882.029465138205;5901.114832775118;5939.91090133657;6047.455728984412;10203.591856325664;10685.786284274116;10694.786104277715;10943.45282735876;11006.064484518585;10539.367637941748;10567.313124646873;10584.523696433833;10630.52162652698;10674;8804.86792698123;8927.598258078531;8996.685116020908;8997;9016.954915225382;8740;8817.823643527221;8830.161134692195;9046.909530904606;9086.772830679285;7916.129225785044;8120.269175773972;8157.265846073882;8164.714235001747;8292.792680183044;7765.145833958373;7999.160088190889;8152.2662960333855;8153.225443583087;8300.958495207486;7225.855482890418;7297.087864016998;7303.379212766974;7336.303051210127;7369.410447164107;4824.324594556695;4984.850454486371;5029.786893766877;5120.641555091257;5150.716710580804;5061.848144555669;5129.8717532062;5146.922796157985;5172.9741351293005;5247.449017853223 17:41:35 INFO - PROCESS | 21143 | |4;prototype.html;343.87620456635614;351.8733256027829;356.10439744043725;360.27404779369556;360.40353215428445;5437.401885792559;5468.851541176347;5475.808346707866;5476.534494567956;5500.862478438041;5364.302640656719;5370.409254981949;5388.575141186472;5400.1629747389115;5410.621256512046;3808.9999999999864;4007.9599204008023;4205.285101532747;4224.746515209082;4246.554111818261;4189.413482112506;4229.70392072555;4236.173946080516;4237.449131612886;4238.300680387732;3966.266240745457;4233.343831706091;4235.708109026746;4238.215930052935;4242.193983143208;4069.3895915612597;4184.497860256758;4184.686148538856;4220.810063547147;4229.513605935326;3736.8878933632036;3750.099976005739;3761.37937240355;3762.360398732195;3766.227923275722;5102.795888164469;5133.820316288912;5150.3047088642925;5153.6392452528335;5250.763715632767;4895.853124406273;4907.950920490785;4926.433460152092;4929.605631549467;4958.9752051239875;5400.540954018913;5499.972500137514;5525.557955363562;5573.386927437979;5722.4277572242445;3991.1818077294083;4064.4106604542176;4150.481189851269;4154.210699966997;4162.52230458189;5786.826395208151;5802.5938184327115;5829.213056237396;5835.708214589254;5843.013375452324;4002.4396584478195;4171.83312667496;4201.264778663722;4202.138561594866;4209.536950935395;4202.894927626772;4218.553239121302;4221.303484924953;4223.894402639959;4254.87235382939;4823.734694591831;4829.251466022772;4852.102361063215;4859.2749573901465;4869.902601947942;5446.319210098738;5644.3508996465935;5649.610233859651;5656.236408084938;5742.770289188469;1448.3337664674157;1448.9130652160904;1454.7163303155994;1456.5630310906686;1467.8678918897351;917.7705573606598;929.9023602521638;930.6882194464795;934.5233930695395;943.2736792669743;4780.402449693788;4867.5132486751045;4924.261360795837;4945.848555878205;4951.925721114186;5047.848564543069;5142.6914385137015;5155.61332900034;5158.252053452228;5181.922271165936;4619.86140415788;4826.903461930812;4847.927281090787;4867.5132486751045;4883.780229889663;2712.3761534847094;2739.9178024658895;2746.615473833665;2750.7759047224195;2775.084222206667;5266.368035835724;5267.841964740987;5282.683039017595;5305.973470132624;5317.41508434072;4819.614430845594;5155.871103222449;5169.405518365361;5190.662606930538;5259.500347466985;5257.237700533401;5691.442848219863;5754.251947246831;5817;5924.822255332347;5784.623999440023;5785.466851284497;5809.331926828299;5824.388439213991;5826.533877289891;5592.692401917933;5723.170140329546;5767.307923049261;5772.422757724194;5786.247787787729;6001.7299221536005;6010.759569617167;6011.458968692838;6016.969915150396;6023.909641355471;4151.107511884959;4155.771432571238;4165.645920096705;4166.479190101238;4167.124903770242;5532.778688852562;5741.74162162712;5747;5824.155497452761;5848.5028772553105;5607.327120745536;5613.747381367766;5626.324841019104;5628.549716022791;5634.1548767683535;5518.641288316247;5606.607537472338;5622.493975542221;5637.590602349413;5679.204911312337;5219.947800521946;5534.308211473566;5541.750621222135;5559.4162612926675;5563.415841336601;5675.716214189357;5710.685912274865;5738.110592858114;5741.569382296261;5774.307083150049;5367.382750983531;5625.718714064362;5641.464060914206;5645.294338207724;5652.293463317085 17:41:35 INFO - PROCESS | 21143 | |5;yui.html;765.9961700191499;788.341734651566;874.3311366804394;887.2103827593439;888.9333300002497;14671.193084380355;14749.188794616291;14750.188739619316;14752.483663071795;14864.777028344584;15088;15110.622234444118;15139;15141.394344226246;15141.470048548303;686.6772616870063;812.8252425728467;824.8515267251893;839.1692224697535;841.8358420108051;822.391430341546;826.4380221449412;829.2205326992607;829.6639860856333;829.8921140251758;883.8674198870157;885.4377470306338;887.2547060469204;887.560657474551;887.9067697891725;726.7746998430478;865.5974971638187;872.3239489395705;877.2981614708208;883.3463237204454;645.822398840318;646.4698946863526;646.9288378278386;647.0456077286012;647.0488382078337;14832.110073395523;14832.925835370863;14855.257237138208;14866.702665946621;14867.182304973223;13687.794683079761;13728.862711372858;13808.861911380858;13951.302434878215;13959.65100872476;12260.386980651021;12430;12534.122611417204;12692;12878.162919410208;4443.7111587746695;4489.3490443885785;4511.774411279423;4594.816207351702;4598.540145985408;55481.72259138679;55934.160987585215;56427.71786141084;58619.70690146522;59678.701606492126;11412.828807567894;11444.713882152846;11494.597689081009;11524.539018439336;11547.191696581327;20030;20045.198192072447;20074.297399590945;20077.799222007594;20092.196312147644;8098.544366305558;8328.6668533258;8562.957185214158;8581.914180858237;8697.521636309937;4679.298105284234;4715.552022557851;4743.95256047442;4774.164521208774;4795.496472870368;3356.0770788032996;3421.6920477157178;3434.708049815744;3436.879709210166;3439.1402149462633;577.4716134736669;587.1486344800057;626.7305058824658;635.0474288567149;671.1275342055309;777.3936329662872;785.862474067036;792.6710415177637;804.2319584796622;816.6406781016334;10063.86588164848;10076.899231007743;10386.480675966322;10397.58409663605;10544.736381590521;748.5059860492049;760.4752720622863;768.8077980504873;770.4106358635648;775.9534427934342;4681.227597446451;4706.95293047072;4868;4873.122837889214;4880.292357608127;72956;73530;73861.63069184619;74678;74713;54287.72856135694;63456.68271658704;64269;65030.674846625465;65096.34903650998;54739.17891231635;56046.71976640172;56210;57995;58632.70683646554;8529.701460449103;8729.956350218208;8857.867131992896;8955.373123881265;9979.201663866728;37355.81322093372;37357.252854942206;37533.43699844559;37937.4309385365;38113.61886381212;47391.76304118595;47408.525914740414;47455.52544474511;47804.5219547814;48704.75647621739;11321.7735645285;11408.372539510076;11648.650540483799;11753.941230293794;11776.52893884235;12343.506259749509;12361.381930903239;12424.254544727346;12498.68753281139;12579.433925473559;11678.532858685898;11891.583794567148;11915.285082895054;12052.216605920587;12711.74576508446;11998.280103193836;12127.45426455794;12220.388980551115;12302.569410070604;12367.93816030914;12028.458719357475;12028.61344433062;12161.817572736592;12449.564265250672;12641.051921105769;9357.578908948977;9509.286803489904;9702.527133011203;9747.220222382335;9920;9437.57530911097;9601.711948641552;9660.855087173839;9738.75653108678;9899.703008909744 17:41:35 INFO - PROCESS | 21143 | __end_tp_report 17:41:35 INFO - PROCESS | 21143 | __start_cc_report 17:41:35 INFO - PROCESS | 21143 | _x_x_mozilla_cycle_collect,821 17:41:35 INFO - PROCESS | 21143 | __end_cc_report 17:41:35 INFO - PROCESS | 21143 | __startTimestamp1463445695973__endTimestamp 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | ------- Summary: start ------- 17:41:35 INFO - PROCESS | 21143 | Number of tests: 6 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#0] dojo.html Cycles:165 Average:5339.01 Median:5495.95 stddev:608.93 (11.1%) stddev-sans-first:584.95 17:41:35 INFO - PROCESS | 21143 | Values: 3101.3 3140.1 3170.4 3205.8 3248.1 5250.7 5314.3 5316.1 5420.4 5436.4 5347.8 5358.4 5359.8 5363.7 5395.7 4833.4 4840.3 5004.5 5056.5 5092.6 4972.8 4975.4 5011.0 5029.9 5041.5 4776.6 4836.4 4840.9 4845.6 4874.2 4835.3 4851.5 4880.1 4885.3 4939.0 4855.4 4880.1 4899.2 4903.1 4956.8 5166.6 5211.5 5239.8 5243.5 5311.4 5652.0 5683.6 5759.8 5784.6 5784.6 5642.2 5772.5 5814.7 5815.7 5820.5 5334.9 5379.3 5417.6 5463.8 5466.0 5902.6 5910.9 5916.8 5967.5 5967.9 5544.7 5647.8 5740.7 5742.7 5752.0 5754.6 5788.4 5791.9 5797.3 5850.4 5720.0 5780.5 5795.4 5796.0 5796.2 5524.1 5604.5 5644.8 5782.0 5784.5 4322.0 4324.2 4329.0 4365.0 4368.7 3857.5 3860.7 3873.5 3888.1 3910.3 5224.2 5340.1 5359.4 5389.9 5456.6 5779.2 5814.4 5841.9 5845.7 5886.3 5444.4 5463.3 5466.3 5468.0 5469.5 4807.5 4922.5 4962.4 4977.7 5001.1 5959.3 6002.2 6011.0 6018.0 6021.6 5669.7 5853.3 5872.0 5875.4 5878.4 5861.8 5939.0 5951.8 5985.3 5985.8 5702.7 5705.6 5709.6 5710.1 5732.3 5632.6 5714.8 5780.5 5838.5 5840.4 5530.7 5555.9 5557.8 5559.1 5611.9 5545.3 5551.5 5555.3 5559.8 5565.3 5290.1 5396.8 5398.8 5441.6 5514.5 5573.4 5603.4 5638.5 5643.9 5644.0 5483.5 5490.5 5494.2 5495.9 5549.2 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#1] ext.html Cycles:180 Average:60162.97 Median:42148.79 stddev:121496.40 (288.3%) stddev-sans-first:121754.94 17:41:35 INFO - PROCESS | 21143 | Values: 603.9 638.3 639.2 650.2 656.0 34024.8 36989.4 37038.6 43385.8 44806.0 48139.3 48307.8 48514.3 48609.0 48698.8 9064.7 9204.0 9220.5 9239.8 9243.5 9022.4 9090.5 9132.1 9143.0 9145.3 9150.0 9176.3 9200.6 9223.0 9225.1 9105.5 9125.8 9157.5 9158.1 9158.3 9084.1 9149.7 9158.2 9167.4 9172.7 43683.6 43981.0 44037.3 44084.3 44093.6 3562.7 4083.9 4189.4 4221.2 4357.5 33089.5 33142.8 33345.5 33349.2 34808.8 4387.8 4399.2 4400.7 4517.6 4601.6 358688.0 359692.0 359833.0 360394.0 360614.0 36859.4 37941.6 37945.2 39642.8 61757.4 39253.6 39410.2 39490.8 39605.4 39609.8 15169.2 15224.6 15304.2 15315.5 15323.1 12393.0 12451.7 12468.5 12494.0 12622.4 8885.5 8898.2 8901.9 8959.8 8984.8 3354.0 3370.0 3407.9 3437.5 3482.1 1022.9 1045.9 1049.5 1059.8 1071.8 32945.5 33411.3 33540.0 33761.0 34109.5 1052.8 1116.8 1131.4 1169.4 1179.7 17537.0 17599.2 17766.6 17864.6 17968.9 562625.0 562741.0 566281.0 567885.0 568894.0 59917.4 61236.0 61245.7 61273.4 61389.0 1305.2 1391.8 1425.6 1440.2 1444.4 33323.0 34615.7 34848.8 34942.1 35047.1 51105.5 51573.5 51933.5 51951.5 52192.0 419669.0 420839.0 421018.0 421733.0 424672.0 25951.4 28629.0 29101.4 29264.1 29356.9 49345.8 49629.5 50006.2 50250.2 50728.7 42129.8 42820.4 43164.4 44169.8 44538.0 42565.6 42566.0 42958.6 43101.0 43663.0 41262.0 41844.0 42167.8 42883.8 42903.4 36660.5 37820.0 38194.4 38504.4 38641.0 28585.0 28994.9 29076.3 29098.7 29254.7 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#2] jquery.html Cycles:180 Average:28790.96 Median:2457.89 stddev:78005.87 (3173.7%) stddev-sans-first:78195.55 17:41:35 INFO - PROCESS | 21143 | Values: 387.6 387.7 395.4 397.8 411.8 17978.6 19529.3 19591.6 19648.2 20500.6 19015.1 19206.6 19708.3 19872.2 20097.9 5591.5 5744.7 5844.0 5900.5 5901.9 5778.6 5808.1 5811.4 5825.9 5829.1 5621.5 5744.2 5763.3 5832.5 5836.5 5657.5 5702.6 5705.7 5732.0 5736.5 5090.8 5201.6 5218.3 5225.3 5229.5 19798.2 20683.8 23423.2 23677.4 23957.3 2428.6 2445.1 2470.7 2490.4 3049.2 10060.3 10766.7 13585.2 13980.5 14977.6 1985.2 2003.6 2053.4 2063.4 2108.0 83107.6 83788.0 86587.6 86840.0 88200.0 11337.8 11373.4 11571.9 11645.0 11887.2 16221.4 16280.5 16387.7 16411.3 16421.8 8092.3 8260.6 8387.0 8458.1 8537.6 7692.8 7845.6 7878.3 7888.3 8031.8 4794.6 4975.5 5028.1 5089.4 5141.2 2022.3 2027.5 2051.9 2054.8 2078.1 923.5 946.1 1014.7 1040.7 1073.5 19035.7 19625.4 19854.5 20074.7 20077.9 987.3 1000.0 1014.9 1040.9 1057.4 10715.4 11227.2 11268.0 11276.2 11358.3 462613.0 462852.0 466389.0 469134.0 500120.0 72814.6 84246.6 89473.0 95198.5 97445.0 1027.6 1035.2 1047.6 1068.2 1069.4 17877.8 17962.7 18180.9 18311.1 18646.2 40965.4 41590.2 41866.4 42119.8 42915.1 58516.7 58569.7 61241.4 62431.7 63182.0 8762.6 8830.9 9013.3 9040.3 9129.2 13610.3 13827.0 13899.6 13940.7 14001.7 6149.3 9056.5 9404.8 11254.3 11297.8 11709.4 11715.8 11826.8 11965.2 12161.4 11916.3 11998.9 12065.4 12132.8 12144.1 8632.6 8658.7 8796.6 8992.1 9188.2 11865.6 12405.9 12513.4 12528.4 12547.4 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#3] mootools.html Cycles:180 Average:6013.79 Median:4654.63 stddev:3550.63 (76.3%) stddev-sans-first:3543.46 17:41:35 INFO - PROCESS | 21143 | Values: 1373.8 1533.6 1549.4 1688.7 1869.6 8602.3 8931.4 8989.6 9162.7 9185.7 9047.3 9255.4 9265.6 9268.0 9268.2 2380.6 2405.9 2406.2 2411.0 2411.1 2368.0 2392.3 2418.0 2422.2 2429.3 2362.4 2365.3 2385.1 2396.7 2399.6 2256.1 2320.9 2341.8 2347.8 2354.7 2243.6 2308.1 2308.2 2308.5 2310.5 7632.9 8744.3 9337.9 9394.8 9401.5 5064.6 5314.5 5325.9 5333.1 5349.8 3369.9 3382.1 3442.5 3474.0 3476.1 1144.5 1145.2 1145.4 1146.5 1178.4 13448.7 13559.8 13581.8 13585.5 13611.8 4626.6 4682.6 4720.5 4778.9 4794.5 11403.0 11420.1 11422.5 11427.6 11431.8 5305.9 5357.9 5358.5 5367.0 5379.7 4875.8 4924.5 5010.4 5020.5 5056.2 4026.6 4054.3 4058.9 4100.2 4139.6 1163.9 1174.8 1175.4 1175.7 1223.0 851.6 873.3 924.9 992.7 995.7 5998.9 6061.8 6067.2 6172.4 6207.2 433.0 434.2 439.0 450.0 454.6 4064.0 4151.8 4152.2 4156.6 4166.7 11002.8 11081.8 11107.2 11122.6 11130.4 11084.3 11114.5 11138.4 11147.1 11161.4 7886.5 8211.2 8242.3 8499.8 8582.6 5639.9 5882.0 5901.1 5939.9 6047.5 10203.6 10685.8 10694.8 10943.5 11006.1 10539.4 10567.3 10584.5 10630.5 10674.0 8804.9 8927.6 8996.7 8997.0 9017.0 8740.0 8817.8 8830.2 9046.9 9086.8 7916.1 8120.3 8157.3 8164.7 8292.8 7765.1 7999.2 8152.3 8153.2 8301.0 7225.9 7297.1 7303.4 7336.3 7369.4 4824.3 4984.9 5029.8 5120.6 5150.7 5061.8 5129.9 5146.9 5173.0 5247.4 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#4] prototype.html Cycles:180 Average:4655.83 Median:5175.66 stddev:1356.92 (26.2%) stddev-sans-first:1321.56 17:41:35 INFO - PROCESS | 21143 | Values: 343.9 351.9 356.1 360.3 360.4 5437.4 5468.9 5475.8 5476.5 5500.9 5364.3 5370.4 5388.6 5400.2 5410.6 3809.0 4008.0 4205.3 4224.7 4246.6 4189.4 4229.7 4236.2 4237.4 4238.3 3966.3 4233.3 4235.7 4238.2 4242.2 4069.4 4184.5 4184.7 4220.8 4229.5 3736.9 3750.1 3761.4 3762.4 3766.2 5102.8 5133.8 5150.3 5153.6 5250.8 4895.9 4908.0 4926.4 4929.6 4959.0 5400.5 5500.0 5525.6 5573.4 5722.4 3991.2 4064.4 4150.5 4154.2 4162.5 5786.8 5802.6 5829.2 5835.7 5843.0 4002.4 4171.8 4201.3 4202.1 4209.5 4202.9 4218.6 4221.3 4223.9 4254.9 4823.7 4829.3 4852.1 4859.3 4869.9 5446.3 5644.4 5649.6 5656.2 5742.8 1448.3 1448.9 1454.7 1456.6 1467.9 917.8 929.9 930.7 934.5 943.3 4780.4 4867.5 4924.3 4945.8 4951.9 5047.8 5142.7 5155.6 5158.3 5181.9 4619.9 4826.9 4847.9 4867.5 4883.8 2712.4 2739.9 2746.6 2750.8 2775.1 5266.4 5267.8 5282.7 5306.0 5317.4 4819.6 5155.9 5169.4 5190.7 5259.5 5257.2 5691.4 5754.3 5817.0 5924.8 5784.6 5785.5 5809.3 5824.4 5826.5 5592.7 5723.2 5767.3 5772.4 5786.2 6001.7 6010.8 6011.5 6017.0 6023.9 4151.1 4155.8 4165.6 4166.5 4167.1 5532.8 5741.7 5747.0 5824.2 5848.5 5607.3 5613.7 5626.3 5628.5 5634.2 5518.6 5606.6 5622.5 5637.6 5679.2 5219.9 5534.3 5541.8 5559.4 5563.4 5675.7 5710.7 5738.1 5741.6 5774.3 5367.4 5625.7 5641.5 5645.3 5652.3 17:41:35 INFO - PROCESS | 21143 | 17:41:35 INFO - PROCESS | 21143 | [#5] yui.html Cycles:180 Average:15848.25 Median:4831.75 stddev:19310.95 (399.7%) stddev-sans-first:19331.91 17:41:35 INFO - PROCESS | 21143 | Values: 766.0 788.3 874.3 887.2 888.9 14671.2 14749.2 14750.2 14752.5 14864.8 15088.0 15110.6 15139.0 15141.4 15141.5 686.7 812.8 824.9 839.2 841.8 822.4 826.4 829.2 829.7 829.9 883.9 885.4 887.3 887.6 887.9 726.8 865.6 872.3 877.3 883.3 645.8 646.5 646.9 647.0 647.0 14832.1 14832.9 14855.3 14866.7 14867.2 13687.8 13728.9 13808.9 13951.3 13959.7 12260.4 12430.0 12534.1 12692.0 12878.2 4443.7 4489.3 4511.8 4594.8 4598.5 55481.7 55934.2 56427.7 58619.7 59678.7 11412.8 11444.7 11494.6 11524.5 11547.2 20030.0 20045.2 20074.3 20077.8 20092.2 8098.5 8328.7 8563.0 8581.9 8697.5 4679.3 4715.6 4744.0 4774.2 4795.5 3356.1 3421.7 3434.7 3436.9 3439.1 577.5 587.1 626.7 635.0 671.1 777.4 785.9 792.7 804.2 816.6 10063.9 10076.9 10386.5 10397.6 10544.7 748.5 760.5 768.8 770.4 776.0 4681.2 4707.0 4868.0 4873.1 4880.3 72956.0 73530.0 73861.6 74678.0 74713.0 54287.7 63456.7 64269.0 65030.7 65096.3 54739.2 56046.7 56210.0 57995.0 58632.7 8529.7 8730.0 8857.9 8955.4 9979.2 37355.8 37357.3 37533.4 37937.4 38113.6 47391.8 47408.5 47455.5 47804.5 48704.8 11321.8 11408.4 11648.7 11753.9 11776.5 12343.5 12361.4 12424.3 12498.7 12579.4 11678.5 11891.6 11915.3 12052.2 12711.7 11998.3 12127.5 12220.4 12302.6 12367.9 12028.5 12028.6 12161.8 12449.6 12641.1 9357.6 9509.3 9702.5 9747.2 9920.0 9437.6 9601.7 9660.9 9738.8 9899.7 17:41:35 INFO - PROCESS | 21143 | -------- Summary: end -------- 17:41:35 INFO - PROCESS | 21143 | 17:41:36 INFO - TEST-INFO | 21143: exit 0 17:41:36 INFO - TEST-OK | dromaeo_css | took 1112570ms 17:41:36 INFO - TEST-START | kraken 17:41:36 INFO - operating with platform_type : linux_ 17:41:36 INFO - Initialising browser for kraken test... 17:41:36 INFO - TEST-INFO | started process 21321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJS2Ks/profile http://localhost:34443/getInfo.html) 17:41:40 INFO - PROCESS | 21321 | __metrics Screen width/height:1600/1200 17:41:40 INFO - PROCESS | 21321 | colorDepth:24 17:41:40 INFO - PROCESS | 21321 | Browser inner width/height: 1024/697 17:41:40 INFO - PROCESS | 21321 | __metrics 17:41:41 ERROR - PROCESS | 21321 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:41:42 INFO - TEST-INFO | 21321: exit 0 17:41:42 INFO - Browser initialized. 17:41:42 INFO - Running cycle 1/1 for kraken test... 17:41:42 INFO - TEST-INFO | started process 21403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJS2Ks/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:54 INFO - PROCESS | 21403 | RSS: Main: 152862720 17:41:54 INFO - PROCESS | 21403 | 17:41:56 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34443/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:57 INFO - PROCESS | 21403 | RSS: Main: 208822272 17:41:57 INFO - PROCESS | 21403 | 17:42:00 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34443/tests/kraken/driver.html?testName=audio-dft) 17:42:00 INFO - PROCESS | 21403 | RSS: Main: 197885952 17:42:00 INFO - PROCESS | 21403 | 17:42:04 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34443/tests/kraken/driver.html?testName=audio-fft) 17:42:04 INFO - PROCESS | 21403 | RSS: Main: 265138176 17:42:04 INFO - PROCESS | 21403 | 17:42:06 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34443/tests/kraken/driver.html?testName=audio-oscillator) 17:42:07 INFO - PROCESS | 21403 | RSS: Main: 174735360 17:42:07 INFO - PROCESS | 21403 | 17:42:09 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:42:10 INFO - PROCESS | 21403 | RSS: Main: 178032640 17:42:10 INFO - PROCESS | 21403 | 17:42:13 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34443/tests/kraken/driver.html?testName=imaging-darkroom) 17:42:14 INFO - PROCESS | 21403 | RSS: Main: 215138304 17:42:14 INFO - PROCESS | 21403 | 17:42:17 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34443/tests/kraken/driver.html?testName=imaging-desaturate) 17:42:18 INFO - PROCESS | 21403 | RSS: Main: 212598784 17:42:18 INFO - PROCESS | 21403 | 17:42:21 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34443/tests/kraken/driver.html?testName=json-parse-financial) 17:42:21 INFO - PROCESS | 21403 | RSS: Main: 213643264 17:42:21 INFO - PROCESS | 21403 | 17:42:23 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:42:24 INFO - PROCESS | 21403 | RSS: Main: 202932224 17:42:24 INFO - PROCESS | 21403 | 17:42:25 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:42:26 INFO - PROCESS | 21403 | RSS: Main: 206598144 17:42:26 INFO - PROCESS | 21403 | 17:42:28 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:42:29 INFO - PROCESS | 21403 | RSS: Main: 216526848 17:42:29 INFO - PROCESS | 21403 | 17:42:31 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:42:32 INFO - PROCESS | 21403 | RSS: Main: 223133696 17:42:32 INFO - PROCESS | 21403 | 17:42:35 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:42:35 INFO - PROCESS | 21403 | RSS: Main: 220176384 17:42:35 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | Cycle 1(1): loaded http://localhost:34443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34443/tests/kraken/driver.html?testName=ai-astar) 17:42:37 INFO - PROCESS | 21403 | RSS: Main: 266653696 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | __start_tp_report 17:42:37 INFO - PROCESS | 21403 | _x_x_mozilla_page_load 17:42:37 INFO - PROCESS | 21403 | _x_x_mozilla_page_load_details 17:42:37 INFO - PROCESS | 21403 | |i|pagename|runs| 17:42:37 INFO - PROCESS | 21403 | |0;ai-astar;112;105;111;113;107;110;109;109;109;109 17:42:37 INFO - PROCESS | 21403 | |1;audio-beat-detection;147;131;150;218;124;154;151;139;173;124 17:42:37 INFO - PROCESS | 21403 | |2;audio-dft;162;162;163;161;162;163;161;161;161;162 17:42:37 INFO - PROCESS | 21403 | |3;audio-fft;75;75;76;157;77;74;75;75;127;74 17:42:37 INFO - PROCESS | 21403 | |4;audio-oscillator;91;93;145;93;93;91;127;92;92;125 17:42:37 INFO - PROCESS | 21403 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;117;117;117 17:42:37 INFO - PROCESS | 21403 | |6;imaging-darkroom;146;145;145;147;145;145;146;146;145;145 17:42:37 INFO - PROCESS | 21403 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 17:42:37 INFO - PROCESS | 21403 | |8;json-parse-financial;55;56;58;57;57;57;57;110;54;54 17:42:37 INFO - PROCESS | 21403 | |9;json-stringify-tinderbox;59;61;60;60;61;61;59;60;60;60 17:42:37 INFO - PROCESS | 21403 | |10;stanford-crypto-aes;78;77;77;78;77;78;79;79;79;80 17:42:37 INFO - PROCESS | 21403 | |11;stanford-crypto-ccm;129;129;131;128;120;118;124;118;191;128 17:42:37 INFO - PROCESS | 21403 | |12;stanford-crypto-pbkdf2;161;162;159;158;159;161;161;166;160;162 17:42:37 INFO - PROCESS | 21403 | |13;stanford-crypto-sha256-iterative;64;65;64;68;66;62;63;62;63;69 17:42:37 INFO - PROCESS | 21403 | __end_tp_report 17:42:37 INFO - PROCESS | 21403 | __start_cc_report 17:42:37 INFO - PROCESS | 21403 | _x_x_mozilla_cycle_collect,1841 17:42:37 INFO - PROCESS | 21403 | __end_cc_report 17:42:37 INFO - PROCESS | 21403 | __startTimestamp1463445757912__endTimestamp 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | ------- Summary: start ------- 17:42:37 INFO - PROCESS | 21403 | Number of tests: 14 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#0] ai-astar Cycles:10 Average:109.40 Median:109.50 stddev:2.32 (2.1%) stddev-sans-first:2.26 17:42:37 INFO - PROCESS | 21403 | Values: 112.0 105.0 111.0 113.0 107.0 110.0 109.0 109.0 109.0 109.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:150.50 stddev:27.89 (18.5%) stddev-sans-first:29.54 17:42:37 INFO - PROCESS | 21403 | Values: 147.0 131.0 150.0 218.0 124.0 154.0 151.0 139.0 173.0 124.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:42:37 INFO - PROCESS | 21403 | Values: 162.0 162.0 163.0 161.0 162.0 163.0 161.0 161.0 161.0 162.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.00 stddev:29.08 (38.8%) stddev-sans-first:30.43 17:42:37 INFO - PROCESS | 21403 | Values: 75.0 75.0 76.0 157.0 77.0 74.0 75.0 75.0 127.0 74.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:92.00 stddev:20.11 (21.9%) stddev-sans-first:20.75 17:42:37 INFO - PROCESS | 21403 | Values: 91.0 93.0 145.0 93.0 93.0 91.0 127.0 92.0 92.0 125.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 17:42:37 INFO - PROCESS | 21403 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:42:37 INFO - PROCESS | 21403 | Values: 146.0 145.0 145.0 147.0 145.0 145.0 146.0 146.0 145.0 145.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 17:42:37 INFO - PROCESS | 21403 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:57.00 stddev:17.10 (30.0%) stddev-sans-first:17.97 17:42:37 INFO - PROCESS | 21403 | Values: 55.0 56.0 58.0 57.0 57.0 57.0 57.0 110.0 54.0 54.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 17:42:37 INFO - PROCESS | 21403 | Values: 59.0 61.0 60.0 60.0 61.0 61.0 59.0 60.0 60.0 60.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:1.03 (1.3%) stddev-sans-first:1.09 17:42:37 INFO - PROCESS | 21403 | Values: 78.0 77.0 77.0 78.0 77.0 78.0 79.0 79.0 79.0 80.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:128.50 stddev:21.42 (16.7%) stddev-sans-first:22.70 17:42:37 INFO - PROCESS | 21403 | Values: 129.0 129.0 131.0 128.0 120.0 118.0 124.0 118.0 191.0 128.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.23 (1.4%) stddev-sans-first:2.37 17:42:37 INFO - PROCESS | 21403 | Values: 161.0 162.0 159.0 158.0 159.0 161.0 161.0 166.0 160.0 162.0 17:42:37 INFO - PROCESS | 21403 | 17:42:37 INFO - PROCESS | 21403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:2.41 (3.7%) stddev-sans-first:2.55 17:42:37 INFO - PROCESS | 21403 | Values: 64.0 65.0 64.0 68.0 66.0 62.0 63.0 62.0 63.0 69.0 17:42:37 INFO - PROCESS | 21403 | -------- Summary: end -------- 17:42:37 INFO - PROCESS | 21403 | 17:42:38 INFO - TEST-INFO | 21403: exit 0 17:42:38 INFO - TEST-OK | kraken | took 62192ms 17:42:38 INFO - SUITE-END | took 1174s 17:42:39 INFO - Completed test suite (00:19:34) 17:42:39 INFO - javascript benchmark 17:42:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.3487167694784, 3140.057982605218, 3170.4451720948828, 3205.759568032398, 3248.1230067881675, 5250.65870718403, 5314.335708036496, 5316.149416093426, 5420.403755586883, 5436.429174936629, 5347.812826551071, 5358.3569971603465, 5359.758810853511, 5363.731813409324, 5395.676259424427, 4833.419989601252, 4840.346553215306, 5004.499550044985, 5056.494350564951, 5092.643514953955, 4972.825951091712, 4975.378077740283, 5010.974945125269, 5029.924551131736, 5041.495850414965, 4776.641751868607, 4836.443808961944, 4840.878978025542, 4845.612351011928, 4874.171390863562, 4835.323054772335, 4851.514848515156, 4880.097182021337, 4885.267209918505, 4939.0, 4855.44162421319, 4880.097182021302, 4899.191633380488, 4903.117438861003, 4956.826511072131, 5166.560842328407, 5211.478852114796, 5239.764210610531, 5243.475652434726, 5311.389190243133, 5652.0, 5683.630564013367, 5759.827205183851, 5784.595078344518, 5784.623999440023, 5642.210090587321, 5772.48047675707, 5814.709264536798, 5815.709214539298, 5820.476157145878, 5334.893302133974, 5379.300690910196, 5417.566594672417, 5463.754131064112, 5466.01611709888, 5902.557308201902, 5910.911336329958, 5916.792912248051, 5967.522598192134, 5967.910481342783, 5544.667319960815, 5647.802326918621, 5740.655560666373, 5742.7415766290615, 5751.971240143856, 5754.597178197486, 5788.421157884178, 5791.942080579224, 5797.275340582427, 5850.444207800252, 5719.971400142973, 5780.479756821906, 5795.362510123968, 5796.0, 5796.1595568642315, 5524.14375771756, 5604.495595396434, 5644.8306550803545, 5782.045962416239, 5784.537237021028, 4322.0, 4324.200022995756, 4328.978355108205, 4364.978175109104, 4368.694191406571, 3857.517810273716, 3860.729748917605, 3873.5351757789244, 3888.0862997195636, 3910.2961466936226, 5224.164133738584, 5340.06548853949, 5359.437259087817, 5389.865253368697, 5456.61803673747, 5779.190913272145, 5814.418558144152, 5841.912371314434, 5845.678487683133, 5886.264216972879, 5444.40111587725, 5463.262459567907, 5466.262054622654, 5468.0, 5469.453054694499, 4807.543283388072, 4922.532359425849, 4962.354893863775, 4977.726225057657, 5001.074801161797, 5959.314678811906, 6002.219711437485, 6011.0, 6018.0, 6021.638701677825, 5669.659820410789, 5853.2976042875125, 5871.972404829223, 5875.41245875409, 5878.382769809108, 5861.824145275648, 5938.990371636745, 5951.791687290924, 5985.281766188085, 5985.790497332572, 5702.657840529581, 5705.629134106436, 5709.628874123168, 5710.057840456278, 5732.3121225453215, 5632.577556683347, 5714.771409143587, 5780.537556995514, 5838.503727183067, 5840.415958404125, 5530.695811730394, 5555.916661250165, 5557.805476808292, 5559.11054231321, 5611.859703507445, 5545.306836645419, 5551.528120109674, 5555.2778138841695, 5559.805406810904, 5565.30433695788, 5290.074237008585, 5396.811111611075, 5398.757055932414, 5441.646292990943, 5514.503694667499, 5573.3869274380595, 5603.355614104267, 5638.4925356718095, 5643.943560564342, 5644.040513112698, 5483.479069488392, 5490.533304669148, 5494.203340515683, 5495.945040549544, 5549.195366671891], "value": 5298.213325689681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.8762053778976, 638.2723694987714, 639.2265358915712, 650.2327253840468, 656.0094257670916, 34024.82987585061, 36989.44515832265, 37038.62961370385, 43385.78307108468, 44806.0, 48139.27791083136, 48307.75846120773, 48514.27228591574, 48609.0, 48698.75650621742, 9064.682736104238, 9203.953980230122, 9220.492872891988, 9239.815203695922, 9243.49160796156, 9022.368434209575, 9090.54547272637, 9132.086791320848, 9143.0, 9145.268378529701, 9149.95425022874, 9176.311776616747, 9200.585973631169, 9223.0, 9225.12361325673, 9105.499197544132, 9125.817483650357, 9157.496337701425, 9158.084191580821, 9158.313126515472, 9084.091590840862, 9149.679761208392, 9158.221551168092, 9167.358284920057, 9172.724818255396, 43683.563164368265, 43981.0, 44037.33943990843, 44084.338734919, 44093.559064409266, 3562.71498280137, 4083.8774836754646, 4189.371594260855, 4221.2190744712325, 4357.542458041923, 33089.50365744516, 33142.834285828656, 33345.49981750276, 33349.16627084318, 34808.825955870314, 4387.802548885308, 4399.23013472641, 4400.691951563392, 4517.593416592523, 4601.562851529099, 358688.0, 359692.0, 359833.0, 360394.0, 360614.0, 36859.447108293396, 37941.62058379381, 37945.24109517794, 39642.80178599089, 61757.382426175165, 39253.60746392557, 39410.21179576393, 39490.80254598766, 39605.40591891124, 39609.80195099064, 15169.24153792306, 15224.619384515476, 15304.158271295186, 15315.46395876139, 15323.080615163126, 12393.0, 12451.688707782378, 12468.5012599495, 12494.0, 12622.368881555885, 8885.511296878605, 8898.243649289883, 8901.910980890238, 8959.776005599782, 8984.820303593891, 3354.0, 3369.983150084234, 3407.9488807667904, 3437.5187473753695, 3482.1294676330917, 1022.882368527614, 1045.9372437653765, 1049.511976930731, 1059.8092343378112, 1071.7534966957644, 32945.505817412755, 33411.3317733644, 33540.0, 33761.0, 34109.48835767466, 1052.8420736889527, 1116.843641890136, 1131.372088490879, 1169.3568537304448, 1179.6814859987926, 17537.0, 17599.20803563843, 17766.644667106586, 17864.55338616519, 17968.9101554494, 562625.0, 562741.0, 566281.0, 567885.0, 568894.0, 59917.40082599118, 61236.0, 61245.69377153175, 61273.38726612766, 61389.0, 1305.1842598376015, 1391.756442622537, 1425.6435891027243, 1440.1862947434665, 1444.4294503671201, 33323.00123985137, 34615.653843461245, 34848.82575587207, 34942.12644683903, 35047.12382190466, 51105.488945110075, 51573.48426515687, 51933.48066519287, 51951.48048519466, 52192.0, 419669.0, 420839.0, 421018.0, 421733.0, 424672.0, 25951.351216219744, 28628.997985070422, 29101.417971640873, 29264.122076337742, 29356.853215733783, 49345.753271233414, 49629.50370496249, 50006.249906250705, 50250.24624630706, 50728.74635626946, 42129.78935105305, 42820.357694635226, 43164.352534712634, 44169.77915110532, 44538.0, 42565.57434425616, 42566.0, 42958.57041429671, 43101.0, 43663.0, 41262.0, 41844.0, 42167.789161053995, 42883.7855810719, 42903.35644965265, 36660.45009324809, 37820.0, 38194.42708359321, 38504.422433662956, 38641.0, 28585.0, 28994.855025724737, 29076.27309317284, 29098.6810207493, 29254.7074529252], "value": 19415.119404048164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.61625990269624, 387.6549870615155, 395.44440061713266, 397.76531846210736, 411.77146683590615, 17978.640427191447, 19529.316473923398, 19591.608167836654, 19648.21407143716, 20500.589988200227, 19015.144318505667, 19206.615867682674, 19708.310209142684, 19872.205111795545, 20097.899510502462, 5591.496765291123, 5744.712764361797, 5844.0, 5900.527957763368, 5901.911471327933, 5778.59549831512, 5808.12878068289, 5811.360750317462, 5825.8834823303505, 5829.125631155318, 5621.4940655341015, 5744.16709577111, 5763.279590051244, 5832.504237139849, 5836.474717275444, 5657.519110875581, 5702.600817942745, 5705.659170095024, 5731.971340143315, 5736.512396446286, 5090.796368145269, 5201.609879259071, 5218.347706536683, 5225.268462415265, 5229.529342359206, 19798.208071677116, 20683.793162068338, 23423.180188693314, 23677.408064798346, 23957.281281561405, 2428.647846062329, 2445.058652418814, 2470.72821989581, 2490.3649569359877, 3049.1919641295076, 10060.295779295378, 10766.730831729192, 13585.184888906599, 13980.510682126076, 14977.550673479813, 1985.1662301833264, 2003.5592169722638, 2053.435305291042, 2063.380985704283, 2108.0303060592146, 83107.58446207791, 83788.0, 86587.56706216492, 86840.0, 88200.0, 11337.829932551018, 11373.431328433546, 11571.942140289244, 11645.0, 11887.227330223508, 16221.432249871197, 16280.511584652479, 16387.672246555, 16411.261493232832, 16421.83578164227, 8092.3121534669035, 8260.628271727786, 8386.958065209636, 8458.069612342637, 8537.573121343908, 7692.807679808049, 7845.646945887449, 7878.330341920886, 7888.329491993245, 8031.83936321282, 4794.568488836021, 4975.4527002029745, 5028.120078986163, 5089.3638295213095, 5141.177411614199, 2022.3023057045295, 2027.5438026443933, 2051.938441846747, 2054.8356131509445, 2078.1271865816093, 923.5474617437408, 946.1484663802632, 1014.7463134216446, 1040.7086015915556, 1073.5061871539024, 19035.714464283046, 19625.411237662895, 19854.503637408892, 20074.698879516818, 20077.899610502147, 987.3039507147587, 1000.049952545085, 1014.8680671512656, 1040.890706475809, 1057.376148072641, 10715.410652414192, 11227.214095013434, 11268.0, 11276.1542884284, 11358.26171298863, 462613.0, 462852.0, 466389.0, 469134.0, 500120.0, 72814.63592682108, 84246.57876710578, 89473.0, 95198.52400737951, 97445.0, 1027.6403258859489, 1035.2442716816765, 1047.554789214596, 1068.1935138970027, 1069.4332004037717, 17877.821221787617, 17962.730559041887, 18180.909095454437, 18311.084445777924, 18646.160922758238, 40965.38551921664, 41590.1681966365, 41866.37200441935, 42119.789401054026, 42915.14169716651, 58516.70741646265, 58569.70715146397, 61241.38758612535, 62431.6878415605, 63182.0, 8762.561871906506, 8830.867536986822, 9013.278937684838, 9040.321975851706, 9129.178373946377, 13610.319484025562, 13827.0, 13899.583012509642, 13940.721185576029, 14001.719965600834, 6149.2620885494025, 9056.547172641473, 9404.777378940695, 11254.268472549258, 11297.813729558608, 11709.355985420883, 11715.824262635897, 11826.763464730486, 11965.162438629213, 12161.39193040362, 11916.344601047025, 11998.880011200126, 12065.396730163633, 12132.75734485323, 12144.089193310714, 8632.61153248118, 8658.696945607126, 8796.560171991503, 8992.100789920956, 9188.173064424234, 11865.5847045353, 12405.937970310091, 12513.436895339913, 12528.37358132108, 12547.372631368578], "value": 9422.927493133308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.7870630052332, 1533.5782659768565, 1549.4112237349807, 1688.7466879968003, 1869.5886904880922, 8602.311815054796, 8931.37480376374, 8989.640414383424, 9162.679306224283, 9185.678501252458, 9047.321450891177, 9255.352125351228, 9265.583048762805, 9267.953660231706, 9268.165865072142, 2380.5952987991996, 2405.867677277749, 2406.1578447543393, 2410.95178096438, 2411.1078900806638, 2368.017272831773, 2392.3181893160454, 2417.9516409671796, 2422.152246713645, 2429.2955043037496, 2362.397588614901, 2365.302235840423, 2385.117506522589, 2396.688430504032, 2399.6040653292184, 2256.1426657869906, 2320.918767843126, 2341.800946919514, 2347.8239132065078, 2354.705661792276, 2243.618584840581, 2308.145985985196, 2308.249818808877, 2308.5382923415386, 2310.4801419680607, 7632.923670763277, 8744.256738177262, 9337.906620933773, 9394.812103757886, 9401.529923503798, 5064.645474816764, 5314.4951229633125, 5325.920111198335, 5333.120035194227, 5349.812756553502, 3369.9157521061925, 3382.0530251529367, 3442.535257740198, 3474.0099071764425, 3476.0788391076385, 1144.5364627325946, 1145.2441388683428, 1145.410113791398, 1146.5012719467059, 1178.381349791358, 13448.663783405394, 13559.796603050961, 13581.796273055912, 13585.456581736718, 13611.795823062663, 4626.629869610423, 4682.6253899687945, 4720.45714742809, 4778.856634300907, 4794.496577859344, 11403.030742386823, 11420.086393088533, 11422.485988130555, 11427.60003399877, 11431.828522572001, 5305.867353316121, 5357.892842143136, 5358.490943360374, 5366.973165134149, 5379.731013449312, 4875.756212189376, 4924.532169443969, 5010.398752149693, 5020.523050310215, 5056.241563765391, 4026.5570787213383, 4054.3107671695884, 4058.898527536835, 4100.159467309194, 4139.586041395836, 1163.8952494275557, 1174.7591743692522, 1175.4375461493855, 1175.6825657072543, 1223.0215827338093, 851.6465666748354, 873.323174539724, 924.8797656304637, 992.6823416506649, 995.6664517386612, 5998.880022399528, 6061.757529698851, 6067.24159480065, 6172.444479996732, 6207.162033125561, 432.9783510824446, 434.19240213203415, 439.0494579235982, 450.0234491154203, 454.59995204220735, 4064.0, 4151.750894946313, 4152.231837110084, 4156.56356082613, 4166.708330416903, 11002.779944401067, 11081.833772493419, 11107.222494425312, 11122.61070862516, 11130.443477826077, 11084.279521831055, 11114.499847506882, 11138.443077846237, 11147.052500537546, 11161.441927903572, 7886.487378320391, 8211.21993410625, 8242.2581967622, 8499.787505312293, 8582.570871456403, 5639.943600564106, 5882.029465138205, 5901.114832775118, 5939.91090133657, 6047.455728984412, 10203.591856325664, 10685.786284274116, 10694.786104277715, 10943.45282735876, 11006.064484518585, 10539.367637941748, 10567.313124646873, 10584.523696433833, 10630.52162652698, 10674.0, 8804.86792698123, 8927.598258078531, 8996.685116020908, 8997.0, 9016.954915225382, 8740.0, 8817.823643527221, 8830.161134692195, 9046.909530904606, 9086.772830679285, 7916.129225785044, 8120.269175773972, 8157.265846073882, 8164.714235001747, 8292.792680183044, 7765.145833958373, 7999.160088190889, 8152.2662960333855, 8153.225443583087, 8300.958495207486, 7225.855482890418, 7297.087864016998, 7303.379212766974, 7336.303051210127, 7369.410447164107, 4824.324594556695, 4984.850454486371, 5029.786893766877, 5120.641555091257, 5150.716710580804, 5061.848144555669, 5129.8717532062, 5146.922796157985, 5172.9741351293005, 5247.449017853223], "value": 4664.25110484181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.87620456635614, 351.8733256027829, 356.10439744043725, 360.27404779369556, 360.40353215428445, 5437.401885792559, 5468.851541176347, 5475.808346707866, 5476.534494567956, 5500.862478438041, 5364.302640656719, 5370.409254981949, 5388.575141186472, 5400.1629747389115, 5410.621256512046, 3808.9999999999864, 4007.9599204008023, 4205.285101532747, 4224.746515209082, 4246.554111818261, 4189.413482112506, 4229.70392072555, 4236.173946080516, 4237.449131612886, 4238.300680387732, 3966.266240745457, 4233.343831706091, 4235.708109026746, 4238.215930052935, 4242.193983143208, 4069.3895915612597, 4184.497860256758, 4184.686148538856, 4220.810063547147, 4229.513605935326, 3736.8878933632036, 3750.099976005739, 3761.37937240355, 3762.360398732195, 3766.227923275722, 5102.795888164469, 5133.820316288912, 5150.3047088642925, 5153.6392452528335, 5250.763715632767, 4895.853124406273, 4907.950920490785, 4926.433460152092, 4929.605631549467, 4958.9752051239875, 5400.540954018913, 5499.972500137514, 5525.557955363562, 5573.386927437979, 5722.4277572242445, 3991.1818077294083, 4064.4106604542176, 4150.481189851269, 4154.210699966997, 4162.52230458189, 5786.826395208151, 5802.5938184327115, 5829.213056237396, 5835.708214589254, 5843.013375452324, 4002.4396584478195, 4171.83312667496, 4201.264778663722, 4202.138561594866, 4209.536950935395, 4202.894927626772, 4218.553239121302, 4221.303484924953, 4223.894402639959, 4254.87235382939, 4823.734694591831, 4829.251466022772, 4852.102361063215, 4859.2749573901465, 4869.902601947942, 5446.319210098738, 5644.3508996465935, 5649.610233859651, 5656.236408084938, 5742.770289188469, 1448.3337664674157, 1448.9130652160904, 1454.7163303155994, 1456.5630310906686, 1467.8678918897351, 917.7705573606598, 929.9023602521638, 930.6882194464795, 934.5233930695395, 943.2736792669743, 4780.402449693788, 4867.5132486751045, 4924.261360795837, 4945.848555878205, 4951.925721114186, 5047.848564543069, 5142.6914385137015, 5155.61332900034, 5158.252053452228, 5181.922271165936, 4619.86140415788, 4826.903461930812, 4847.927281090787, 4867.5132486751045, 4883.780229889663, 2712.3761534847094, 2739.9178024658895, 2746.615473833665, 2750.7759047224195, 2775.084222206667, 5266.368035835724, 5267.841964740987, 5282.683039017595, 5305.973470132624, 5317.41508434072, 4819.614430845594, 5155.871103222449, 5169.405518365361, 5190.662606930538, 5259.500347466985, 5257.237700533401, 5691.442848219863, 5754.251947246831, 5817.0, 5924.822255332347, 5784.623999440023, 5785.466851284497, 5809.331926828299, 5824.388439213991, 5826.533877289891, 5592.692401917933, 5723.170140329546, 5767.307923049261, 5772.422757724194, 5786.247787787729, 6001.7299221536005, 6010.759569617167, 6011.458968692838, 6016.969915150396, 6023.909641355471, 4151.107511884959, 4155.771432571238, 4165.645920096705, 4166.479190101238, 4167.124903770242, 5532.778688852562, 5741.74162162712, 5747.0, 5824.155497452761, 5848.5028772553105, 5607.327120745536, 5613.747381367766, 5626.324841019104, 5628.549716022791, 5634.1548767683535, 5518.641288316247, 5606.607537472338, 5622.493975542221, 5637.590602349413, 5679.204911312337, 5219.947800521946, 5534.308211473566, 5541.750621222135, 5559.4162612926675, 5563.415841336601, 5675.716214189357, 5710.685912274865, 5738.110592858114, 5741.569382296261, 5774.307083150049, 5367.382750983531, 5625.718714064362, 5641.464060914206, 5645.294338207724, 5652.293463317085], "value": 4229.416915294359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.9961700191499, 788.341734651566, 874.3311366804394, 887.2103827593439, 888.9333300002497, 14671.193084380355, 14749.188794616291, 14750.188739619316, 14752.483663071795, 14864.777028344584, 15088.0, 15110.622234444118, 15139.0, 15141.394344226246, 15141.470048548303, 686.6772616870063, 812.8252425728467, 824.8515267251893, 839.1692224697535, 841.8358420108051, 822.391430341546, 826.4380221449412, 829.2205326992607, 829.6639860856333, 829.8921140251758, 883.8674198870157, 885.4377470306338, 887.2547060469204, 887.560657474551, 887.9067697891725, 726.7746998430478, 865.5974971638187, 872.3239489395705, 877.2981614708208, 883.3463237204454, 645.822398840318, 646.4698946863526, 646.9288378278386, 647.0456077286012, 647.0488382078337, 14832.110073395523, 14832.925835370863, 14855.257237138208, 14866.702665946621, 14867.182304973223, 13687.794683079761, 13728.862711372858, 13808.861911380858, 13951.302434878215, 13959.65100872476, 12260.386980651021, 12430.0, 12534.122611417204, 12692.0, 12878.162919410208, 4443.7111587746695, 4489.3490443885785, 4511.774411279423, 4594.816207351702, 4598.540145985408, 55481.72259138679, 55934.160987585215, 56427.71786141084, 58619.70690146522, 59678.701606492126, 11412.828807567894, 11444.713882152846, 11494.597689081009, 11524.539018439336, 11547.191696581327, 20030.0, 20045.198192072447, 20074.297399590945, 20077.799222007594, 20092.196312147644, 8098.544366305558, 8328.6668533258, 8562.957185214158, 8581.914180858237, 8697.521636309937, 4679.298105284234, 4715.552022557851, 4743.95256047442, 4774.164521208774, 4795.496472870368, 3356.0770788032996, 3421.6920477157178, 3434.708049815744, 3436.879709210166, 3439.1402149462633, 577.4716134736669, 587.1486344800057, 626.7305058824658, 635.0474288567149, 671.1275342055309, 777.3936329662872, 785.862474067036, 792.6710415177637, 804.2319584796622, 816.6406781016334, 10063.86588164848, 10076.899231007743, 10386.480675966322, 10397.58409663605, 10544.736381590521, 748.5059860492049, 760.4752720622863, 768.8077980504873, 770.4106358635648, 775.9534427934342, 4681.227597446451, 4706.95293047072, 4868.0, 4873.122837889214, 4880.292357608127, 72956.0, 73530.0, 73861.63069184619, 74678.0, 74713.0, 54287.72856135694, 63456.68271658704, 64269.0, 65030.674846625465, 65096.34903650998, 54739.17891231635, 56046.71976640172, 56210.0, 57995.0, 58632.70683646554, 8529.701460449103, 8729.956350218208, 8857.867131992896, 8955.373123881265, 9979.201663866728, 37355.81322093372, 37357.252854942206, 37533.43699844559, 37937.4309385365, 38113.61886381212, 47391.76304118595, 47408.525914740414, 47455.52544474511, 47804.5219547814, 48704.75647621739, 11321.7735645285, 11408.372539510076, 11648.650540483799, 11753.941230293794, 11776.52893884235, 12343.506259749509, 12361.381930903239, 12424.254544727346, 12498.68753281139, 12579.433925473559, 11678.532858685898, 11891.583794567148, 11915.285082895054, 12052.216605920587, 12711.74576508446, 11998.280103193836, 12127.45426455794, 12220.388980551115, 12302.569410070604, 12367.93816030914, 12028.458719357475, 12028.61344433062, 12161.817572736592, 12449.564265250672, 12641.051921105769, 9357.578908948977, 9509.286803489904, 9702.527133011203, 9747.220222382335, 9920.0, 9437.57530911097, 9601.711948641552, 9660.855087173839, 9738.75653108678, 9899.703008909744], "value": 6985.217079095151, "unit": "score"}], "name": "dromaeo_css", "value": 7149.740326371989, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 113.0, 107.0, 110.0, 109.0, 109.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 131.0, 150.0, 218.0, 124.0, 154.0, 151.0, 139.0, 173.0, 124.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 157.0, 77.0, 74.0, 75.0, 75.0, 127.0, 74.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 145.0, 93.0, 93.0, 91.0, 127.0, 92.0, 92.0, 125.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 57.0, 57.0, 57.0, 57.0, 110.0, 54.0, 54.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 61.0, 61.0, 59.0, 60.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 77.0, 78.0, 79.0, 79.0, 79.0, 80.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 131.0, 128.0, 120.0, 118.0, 124.0, 118.0, 191.0, 128.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 158.0, 159.0, 161.0, 161.0, 166.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 68.0, 66.0, 62.0, 63.0, 62.0, 63.0, 69.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1528.9999999999998, "alertThreshold": 2.0}]} 17:42:39 INFO - Return code: 0 17:42:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:42:39 ERROR - # TBPL SUCCESS # 17:42:39 INFO - Running post-action listener: _resource_record_post_action 17:42:39 INFO - ##### 17:42:39 INFO - ##### Finished run-tests step (success) 17:42:39 INFO - ##### 17:42:39 INFO - Running post-run listener: _resource_record_post_run 17:42:39 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 537739264; Read time: 408; Write time: 485472 17:42:39 INFO - TinderboxPrint: CPU usage
13.1% 17:42:39 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 408 17:42:39 INFO - TinderboxPrint: I/O write bytes / time
537,739,264 / 485,472 17:42:39 INFO - TinderboxPrint: CPU idle
8,270.8 (86.9%) 17:42:39 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 17:42:39 INFO - TinderboxPrint: Swap in / out
0 / 0 17:42:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246452224; Read time: 208; Write time: 249636 17:42:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291287040; Read time: 200; Write time: 235836 17:42:39 INFO - Running post-run listener: _upload_blobber_files 17:42:39 INFO - Blob upload gear active. 17:42:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:42:39 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 17:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:42:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:40 INFO - (blobuploader) - INFO - Done attempting. 17:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:42:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:41 INFO - (blobuploader) - INFO - Done attempting. 17:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:45 INFO - (blobuploader) - INFO - Done attempting. 17:42:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:45 INFO - Return code: 0 17:42:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbf19096d3196966ad6e1b1c03c9542e0eb93927a761639f60e9008484ac96a725857cb3910f1a259d16c98dd67de28277ebe0258bf4ba0c1508bcf260360fb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7834095b3f2b7262dc62fbede446bb4b0e11fa29b82a5937c887e2cd817712baf0c7a6ce6a1c64ad4a1e0d267d2f1fe87fe5b0843508257d9040ca382be3a0c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2022a93d7d2782f62a6d111997ea2bee5392f30788774e3eaa21774ec63b66902df95bbd45cfcab4e19f5b576a5573ab855d006dbcbc563d9a91213efb09909"} 17:42:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:45 INFO - Contents: 17:42:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbf19096d3196966ad6e1b1c03c9542e0eb93927a761639f60e9008484ac96a725857cb3910f1a259d16c98dd67de28277ebe0258bf4ba0c1508bcf260360fb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7834095b3f2b7262dc62fbede446bb4b0e11fa29b82a5937c887e2cd817712baf0c7a6ce6a1c64ad4a1e0d267d2f1fe87fe5b0843508257d9040ca382be3a0c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2022a93d7d2782f62a6d111997ea2bee5392f30788774e3eaa21774ec63b66902df95bbd45cfcab4e19f5b576a5573ab855d006dbcbc563d9a91213efb09909"} 17:42:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:45 INFO - Copying logs to upload dir... 17:42:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.738368 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-16 17:42:45.147633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 17:42:45.150936) ========= 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=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 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/sha512/cbf19096d3196966ad6e1b1c03c9542e0eb93927a761639f60e9008484ac96a725857cb3910f1a259d16c98dd67de28277ebe0258bf4ba0c1508bcf260360fb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7834095b3f2b7262dc62fbede446bb4b0e11fa29b82a5937c887e2cd817712baf0c7a6ce6a1c64ad4a1e0d267d2f1fe87fe5b0843508257d9040ca382be3a0c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2022a93d7d2782f62a6d111997ea2bee5392f30788774e3eaa21774ec63b66902df95bbd45cfcab4e19f5b576a5573ab855d006dbcbc563d9a91213efb09909"} build_url:https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/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/sha512/cbf19096d3196966ad6e1b1c03c9542e0eb93927a761639f60e9008484ac96a725857cb3910f1a259d16c98dd67de28277ebe0258bf4ba0c1508bcf260360fb0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7834095b3f2b7262dc62fbede446bb4b0e11fa29b82a5937c887e2cd817712baf0c7a6ce6a1c64ad4a1e0d267d2f1fe87fe5b0843508257d9040ca382be3a0c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2022a93d7d2782f62a6d111997ea2bee5392f30788774e3eaa21774ec63b66902df95bbd45cfcab4e19f5b576a5573ab855d006dbcbc563d9a91213efb09909"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 17:42:45.175193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:42:45.175502) ========= 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=0e2a256762fed810e2f0f810000001b3-1463444528.561695-1231879000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:42:45.260328) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 17:42:45.260650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 17:42:45.260943) ========= ========= Total master_lag: 0.17 =========