builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1463385795.88 results: success (0) buildid: 20160515223014 builduid: 43e29b8a84934a3a86989b1553e93f31 revision: d0be57e84807ce0853b2406de7ff6abb195ac898 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:15.881921) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:15.882359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:15.882848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:15.931844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:15.932147) ========= 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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 01:03:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-05-16 01:03:16 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085332 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.040368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.040890) ========= 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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022699 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.117513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.118015) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0be57e84807ce0853b2406de7ff6abb195ac898 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d0be57e84807ce0853b2406de7ff6abb195ac898 --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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 01:03:16,352 truncating revision to first 12 chars 2016-05-16 01:03:16,352 Setting DEBUG logging. 2016-05-16 01:03:16,352 attempt 1/10 2016-05-16 01:03:16,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0be57e84807?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 01:03:16,749 unpacking tar archive at: mozilla-central-d0be57e84807/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685905 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.829123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.829585) ========= script_repo_revision: d0be57e84807ce0853b2406de7ff6abb195ac898 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.830272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.831004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 01:03:16.842621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 01:03:16.842938) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:03:17 INFO - MultiFileLogger online at 20160516 01:03:17 in /builds/slave/test 01:03:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:03:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:03:17 INFO - {'append_to_log': False, 01:03:17 INFO - 'base_work_dir': '/builds/slave/test', 01:03:17 INFO - 'blob_upload_branch': 'Firefox', 01:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:03:17 INFO - 'branch': 'Firefox', 01:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 01:03:17 INFO - 'config_files': ('talos/linux_config.py',), 01:03:17 INFO - 'default_actions': ('clobber', 01:03:17 INFO - 'read-buildbot-config', 01:03:17 INFO - 'download-and-extract', 01:03:17 INFO - 'populate-webroot', 01:03:17 INFO - 'create-virtualenv', 01:03:17 INFO - 'install', 01:03:17 INFO - 'run-tests'), 01:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:03:17 INFO - 'download_minidump_stackwalk': True, 01:03:17 INFO - 'download_symbols': 'ondemand', 01:03:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:03:17 INFO - 'tooltool.py': '/tools/tooltool.py', 01:03:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:03:17 INFO - '/tools/misc-python/virtualenv.py')}, 01:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:03:17 INFO - 'installer_path': 'installer.exe', 01:03:17 INFO - 'log_level': 'info', 01:03:17 INFO - 'log_name': 'talos', 01:03:17 INFO - 'log_to_console': True, 01:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:03:17 INFO - 'opt_config_files': (), 01:03:17 INFO - 'pip_index': False, 01:03:17 INFO - 'sps_profile': False, 01:03:17 INFO - 'sps_profile_interval': 0, 01:03:17 INFO - 'suite': 'dromaeojs', 01:03:17 INFO - 'system_bits': '32', 01:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:03:17 INFO - 'title': 'talos-linux64-ix-016', 01:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:03:17 INFO - 'use_talos_json': True, 01:03:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:03:17 INFO - 'work_dir': 'build'} 01:03:17 INFO - ##### 01:03:17 INFO - ##### Running clobber step. 01:03:17 INFO - ##### 01:03:17 INFO - Running pre-action listener: _resource_record_pre_action 01:03:17 INFO - Running main action method: clobber 01:03:17 INFO - rmtree: /builds/slave/test/build 01:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:03:17 INFO - Running post-action listener: _resource_record_post_action 01:03:17 INFO - ##### 01:03:17 INFO - ##### Finished clobber step (success) 01:03:17 INFO - ##### 01:03:17 INFO - ##### 01:03:17 INFO - ##### Running read-buildbot-config step. 01:03:17 INFO - ##### 01:03:17 INFO - Running pre-action listener: _resource_record_pre_action 01:03:17 INFO - Running main action method: read_buildbot_config 01:03:17 INFO - Using buildbot properties: 01:03:17 INFO - { 01:03:17 INFO - "project": "", 01:03:17 INFO - "product": "firefox", 01:03:17 INFO - "script_repo_revision": "production", 01:03:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:03:17 INFO - "repository": "", 01:03:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 01:03:17 INFO - "buildid": "20160515223014", 01:03:17 INFO - "pgo_build": "True", 01:03:17 INFO - "basedir": "/builds/slave/test", 01:03:17 INFO - "buildnumber": 443, 01:03:17 INFO - "slavename": "talos-linux64-ix-016", 01:03:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:03:17 INFO - "platform": "ubuntu64_hw", 01:03:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:03:17 INFO - "branch": "mozilla-central", 01:03:17 INFO - "repo_path": "mozilla-central", 01:03:17 INFO - "revision": "d0be57e84807ce0853b2406de7ff6abb195ac898", 01:03:17 INFO - "stage_platform": "linux64-pgo", 01:03:17 INFO - "builduid": "43e29b8a84934a3a86989b1553e93f31", 01:03:17 INFO - "slavebuilddir": "test" 01:03:17 INFO - } 01:03:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:03:17 INFO - Running post-action listener: _resource_record_post_action 01:03:17 INFO - ##### 01:03:17 INFO - ##### Finished read-buildbot-config step (success) 01:03:17 INFO - ##### 01:03:17 INFO - ##### 01:03:17 INFO - ##### Running download-and-extract step. 01:03:17 INFO - ##### 01:03:17 INFO - Running pre-action listener: _resource_record_pre_action 01:03:17 INFO - Running main action method: download_and_extract 01:03:17 INFO - mkdir: /builds/slave/test/build/tests 01:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:17 INFO - https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:03:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:03:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:03:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:26 INFO - Downloaded 1361 bytes. 01:03:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:03:26 INFO - Using the following test package requirements: 01:03:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:03:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:03:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:03:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'jsshell-linux-x86_64.zip'], 01:03:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:03:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:03:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:03:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:03:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:03:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:03:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:03:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:26 INFO - https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:36 INFO - Downloaded 24022986 bytes. 01:03:36 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'] 01:03:36 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 01:03:37 INFO - Return code: 0 01:03:37 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 01:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:37 INFO - https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:38 INFO - Downloaded 24022986 bytes. 01:03:38 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'] 01:03:38 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 01:03:40 INFO - Return code: 0 01:03: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')]} 01:03:40 INFO - https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:41 INFO - Downloaded 10840194 bytes. 01:03:41 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'] 01:03:41 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 01:03:41 INFO - Return code: 0 01:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:41 INFO - https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzJnqMlMRXCWg-DM8esqgA/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 01:03:42 INFO - Downloaded 58395837 bytes. 01:03:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:03:42 INFO - mkdir: /builds/slave/test/properties 01:03:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:03:42 INFO - Writing to file /builds/slave/test/properties/build_url 01:03:42 INFO - Contents: 01:03:42 INFO - build_url:https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:03:43 INFO - Running post-action listener: _resource_record_post_action 01:03:43 INFO - Running post-action listener: set_extra_try_arguments 01:03:43 INFO - ##### 01:03:43 INFO - ##### Finished download-and-extract step (success) 01:03:43 INFO - ##### 01:03:43 INFO - ##### 01:03:43 INFO - ##### Running populate-webroot step. 01:03:43 INFO - ##### 01:03:43 INFO - Running pre-action listener: _resource_record_pre_action 01:03:43 INFO - Running main action method: populate_webroot 01:03:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:03:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:03:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:03:43 INFO - '--tppagecycles', 01:03:43 INFO - '7'], 01:03:43 INFO - 'tests': ['tsvgm']}}, 01:03:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:03:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:03:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:03:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:03:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:03:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['damp', 'tps']}, 01:03:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'tests': ['damp', 'tps']}, 01:03:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['dromaeo_dom']}, 01:03:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:03:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'other-e10s': {'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['a11yr', 01:03:43 INFO - 'ts_paint', 01:03:43 INFO - 'tpaint', 01:03:43 INFO - 'sessionrestore', 01:03:43 INFO - 'sessionrestore_no_auto_restore', 01:03:43 INFO - 'tabpaint']}, 01:03:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['tsvgx', 01:03:43 INFO - 'tsvgr_opacity', 01:03:43 INFO - 'tart', 01:03:43 INFO - 'tscrollx', 01:03:43 INFO - 'cart']}, 01:03:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:03:43 INFO - 'tsvgr_opacity', 01:03:43 INFO - 'tart', 01:03:43 INFO - 'tscrollx', 01:03:43 INFO - 'cart']}, 01:03:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'talos_options': ['--disable-e10s'], 01:03:43 INFO - 'tests': ['tp5o']}, 01:03:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'tests': ['tp5o']}, 01:03:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'talos_options': ['--disable-e10s', 01:03:43 INFO - '--xperf_path', 01:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:43 INFO - 'tests': ['tp5n']}, 01:03:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:03:43 INFO - 'talos_options': ['--xperf_path', 01:03:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:03:43 INFO - 'tests': ['tp5n']}}, 01:03:43 INFO - 'talos.zip': {'path': '', 01:03:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:03:43 INFO - Running post-action listener: _resource_record_post_action 01:03:43 INFO - ##### 01:03:43 INFO - ##### Finished populate-webroot step (success) 01:03:43 INFO - ##### 01:03:43 INFO - ##### 01:03:43 INFO - ##### Running create-virtualenv step. 01:03:43 INFO - ##### 01:03:43 INFO - Running pre-action listener: _resource_record_pre_action 01:03:43 INFO - Running main action method: create_virtualenv 01:03:43 INFO - Creating virtualenv /builds/slave/test/build/venv 01:03:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:03:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:03:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:03:43 INFO - Using real prefix '/usr' 01:03:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:03:43 INFO - Installing distribute.............................................................................................................................................................................................done. 01:03:45 INFO - Installing pip.................done. 01:03:45 INFO - Return code: 0 01:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:45 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:03:45 INFO - Using env: {'DISPLAY': ':0', 01:03:45 INFO - 'HOME': '/home/cltbld', 01:03:45 INFO - 'LANG': 'en_US.UTF-8', 01:03:45 INFO - 'LANGUAGE': 'en_US:en', 01:03:45 INFO - 'LOGNAME': 'cltbld', 01:03:45 INFO - 'MAIL': '/var/mail/cltbld', 01:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:45 INFO - 'MOZ_NO_REMOTE': '1', 01:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:45 INFO - 'NO_EM_RESTART': '1', 01:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:45 INFO - 'PWD': '/builds/slave/test', 01:03:45 INFO - 'SHELL': '/bin/bash', 01:03:45 INFO - 'SHLVL': '1', 01:03:45 INFO - 'TERM': 'linux', 01:03:45 INFO - 'TMOUT': '86400', 01:03:45 INFO - 'USER': 'cltbld', 01:03:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:45 INFO - '_': '/tools/buildbot/bin/python'} 01:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:03:46 INFO - Cleaning up... 01:03:46 INFO - Return code: 0 01:03:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:46 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:03:46 INFO - Using env: {'DISPLAY': ':0', 01:03:46 INFO - 'HOME': '/home/cltbld', 01:03:46 INFO - 'LANG': 'en_US.UTF-8', 01:03:46 INFO - 'LANGUAGE': 'en_US:en', 01:03:46 INFO - 'LOGNAME': 'cltbld', 01:03:46 INFO - 'MAIL': '/var/mail/cltbld', 01:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:46 INFO - 'MOZ_NO_REMOTE': '1', 01:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:46 INFO - 'NO_EM_RESTART': '1', 01:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:46 INFO - 'PWD': '/builds/slave/test', 01:03:46 INFO - 'SHELL': '/bin/bash', 01:03:46 INFO - 'SHLVL': '1', 01:03:46 INFO - 'TERM': 'linux', 01:03:46 INFO - 'TMOUT': '86400', 01:03:46 INFO - 'USER': 'cltbld', 01:03:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:46 INFO - '_': '/tools/buildbot/bin/python'} 01:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:46 INFO - Downloading/unpacking psutil>=3.1.1 01:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:48 INFO - Installing collected packages: psutil 01:03:48 INFO - Running setup.py install for psutil 01:03:48 INFO - building 'psutil._psutil_linux' extension 01:03:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:03:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:03:48 INFO - building 'psutil._psutil_posix' extension 01:03:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:03:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:03:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:03:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:03:48 INFO - Successfully installed psutil 01:03:48 INFO - Cleaning up... 01:03:48 INFO - Return code: 0 01:03:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:48 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:03:48 INFO - Using env: {'DISPLAY': ':0', 01:03:48 INFO - 'HOME': '/home/cltbld', 01:03:48 INFO - 'LANG': 'en_US.UTF-8', 01:03:48 INFO - 'LANGUAGE': 'en_US:en', 01:03:48 INFO - 'LOGNAME': 'cltbld', 01:03:48 INFO - 'MAIL': '/var/mail/cltbld', 01:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:48 INFO - 'MOZ_NO_REMOTE': '1', 01:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:48 INFO - 'NO_EM_RESTART': '1', 01:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:48 INFO - 'PWD': '/builds/slave/test', 01:03:48 INFO - 'SHELL': '/bin/bash', 01:03:48 INFO - 'SHLVL': '1', 01:03:48 INFO - 'TERM': 'linux', 01:03:48 INFO - 'TMOUT': '86400', 01:03:48 INFO - 'USER': 'cltbld', 01:03:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:48 INFO - '_': '/tools/buildbot/bin/python'} 01:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:03:51 INFO - Installing collected packages: mozsystemmonitor 01:03:51 INFO - Running setup.py install for mozsystemmonitor 01:03:51 INFO - Successfully installed mozsystemmonitor 01:03:51 INFO - Cleaning up... 01:03:51 INFO - Return code: 0 01:03:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:51 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:03:51 INFO - Using env: {'DISPLAY': ':0', 01:03:51 INFO - 'HOME': '/home/cltbld', 01:03:51 INFO - 'LANG': 'en_US.UTF-8', 01:03:51 INFO - 'LANGUAGE': 'en_US:en', 01:03:51 INFO - 'LOGNAME': 'cltbld', 01:03:51 INFO - 'MAIL': '/var/mail/cltbld', 01:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:51 INFO - 'MOZ_NO_REMOTE': '1', 01:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:51 INFO - 'NO_EM_RESTART': '1', 01:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:51 INFO - 'PWD': '/builds/slave/test', 01:03:51 INFO - 'SHELL': '/bin/bash', 01:03:51 INFO - 'SHLVL': '1', 01:03:51 INFO - 'TERM': 'linux', 01:03:51 INFO - 'TMOUT': '86400', 01:03:51 INFO - 'USER': 'cltbld', 01:03:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:51 INFO - '_': '/tools/buildbot/bin/python'} 01:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:51 INFO - Downloading/unpacking blobuploader==1.2.4 01:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:53 INFO - Downloading blobuploader-1.2.4.tar.gz 01:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:03:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:03:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:53 INFO - Downloading docopt-0.6.1.tar.gz 01:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:03:54 INFO - Installing collected packages: blobuploader, requests, docopt 01:03:54 INFO - Running setup.py install for blobuploader 01:03:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:03:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:03:54 INFO - Running setup.py install for requests 01:03:54 INFO - Running setup.py install for docopt 01:03:54 INFO - Successfully installed blobuploader requests docopt 01:03:54 INFO - Cleaning up... 01:03:54 INFO - Return code: 0 01:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:54 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:03:54 INFO - Using env: {'DISPLAY': ':0', 01:03:54 INFO - 'HOME': '/home/cltbld', 01:03:54 INFO - 'LANG': 'en_US.UTF-8', 01:03:54 INFO - 'LANGUAGE': 'en_US:en', 01:03:54 INFO - 'LOGNAME': 'cltbld', 01:03:54 INFO - 'MAIL': '/var/mail/cltbld', 01:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:54 INFO - 'MOZ_NO_REMOTE': '1', 01:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:54 INFO - 'NO_EM_RESTART': '1', 01:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:54 INFO - 'PWD': '/builds/slave/test', 01:03:54 INFO - 'SHELL': '/bin/bash', 01:03:54 INFO - 'SHLVL': '1', 01:03:54 INFO - 'TERM': 'linux', 01:03:54 INFO - 'TMOUT': '86400', 01:03:54 INFO - 'USER': 'cltbld', 01:03:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:54 INFO - '_': '/tools/buildbot/bin/python'} 01:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:54 INFO - Running setup.py (path:/tmp/pip-kLctm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:54 INFO - Running setup.py (path:/tmp/pip-2Ix4w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:54 INFO - Running setup.py (path:/tmp/pip-fH3rkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:55 INFO - Running setup.py (path:/tmp/pip-FKcmm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:55 INFO - Running setup.py (path:/tmp/pip-fapQ9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:55 INFO - Running setup.py (path:/tmp/pip-baHhR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:55 INFO - Running setup.py (path:/tmp/pip-r4ApAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:55 INFO - Running setup.py (path:/tmp/pip-osd91R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:55 INFO - Running setup.py (path:/tmp/pip-hD92q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:55 INFO - Running setup.py (path:/tmp/pip-AASpnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:55 INFO - Running setup.py (path:/tmp/pip-bbxj4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:55 INFO - Running setup.py (path:/tmp/pip-4MHrcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:55 INFO - Running setup.py (path:/tmp/pip-xEscwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:55 INFO - Running setup.py (path:/tmp/pip-C2A7u8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:55 INFO - Running setup.py (path:/tmp/pip-VO7KL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:55 INFO - Running setup.py (path:/tmp/pip-1xMzoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:55 INFO - Running setup.py (path:/tmp/pip-sLEe8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:03:56 INFO - Running setup.py install for manifestparser 01:03:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:03:56 INFO - Running setup.py install for mozcrash 01:03:56 INFO - Running setup.py install for mozdebug 01:03:56 INFO - Running setup.py install for mozdevice 01:03:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:03:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:03:56 INFO - Running setup.py install for mozfile 01:03:56 INFO - Running setup.py install for mozhttpd 01:03:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:03:56 INFO - Running setup.py install for mozinfo 01:03:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for mozInstall 01:03:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for mozleak 01:03:57 INFO - Running setup.py install for mozlog 01:03:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for moznetwork 01:03:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for mozprocess 01:03:57 INFO - Running setup.py install for mozprofile 01:03:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for mozrunner 01:03:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:03:57 INFO - Running setup.py install for mozscreenshot 01:03:57 INFO - Running setup.py install for moztest 01:03:57 INFO - Running setup.py install for mozversion 01:03:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:03:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:03:58 INFO - Cleaning up... 01:03:58 INFO - Return code: 0 01:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:03:58 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:03:58 INFO - Using env: {'DISPLAY': ':0', 01:03:58 INFO - 'HOME': '/home/cltbld', 01:03:58 INFO - 'LANG': 'en_US.UTF-8', 01:03:58 INFO - 'LANGUAGE': 'en_US:en', 01:03:58 INFO - 'LOGNAME': 'cltbld', 01:03:58 INFO - 'MAIL': '/var/mail/cltbld', 01:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:03:58 INFO - 'MOZ_NO_REMOTE': '1', 01:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:03:58 INFO - 'NO_EM_RESTART': '1', 01:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:03:58 INFO - 'PWD': '/builds/slave/test', 01:03:58 INFO - 'SHELL': '/bin/bash', 01:03:58 INFO - 'SHLVL': '1', 01:03:58 INFO - 'TERM': 'linux', 01:03:58 INFO - 'TMOUT': '86400', 01:03:58 INFO - 'USER': 'cltbld', 01:03:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:03:58 INFO - '_': '/tools/buildbot/bin/python'} 01:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:03:58 INFO - Running setup.py (path:/tmp/pip-jUP8kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:03:58 INFO - Running setup.py (path:/tmp/pip-dcJU5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:03:58 INFO - Running setup.py (path:/tmp/pip-oUzUyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:03:58 INFO - Running setup.py (path:/tmp/pip-MnN4an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:03:58 INFO - Running setup.py (path:/tmp/pip-dWHaYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:03:58 INFO - Running setup.py (path:/tmp/pip-fE_4ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:03:58 INFO - Running setup.py (path:/tmp/pip-rOVCDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:03:58 INFO - Running setup.py (path:/tmp/pip-M97NEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:03:58 INFO - Running setup.py (path:/tmp/pip-NGjOkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:03:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:03:58 INFO - Running setup.py (path:/tmp/pip-y32y3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:03:59 INFO - Running setup.py (path:/tmp/pip-5Dx97Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:03:59 INFO - Running setup.py (path:/tmp/pip-BonUBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:03:59 INFO - Running setup.py (path:/tmp/pip-jWLvDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:03:59 INFO - Running setup.py (path:/tmp/pip-c2avQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:59 INFO - Running setup.py (path:/tmp/pip-L3FuCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:03:59 INFO - Running setup.py (path:/tmp/pip-S77GbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:03:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:03:59 INFO - Running setup.py (path:/tmp/pip-vT_RG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:03:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:01 INFO - Downloading blessings-1.6.tar.gz 01:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:04:01 INFO - Installing collected packages: blessings 01:04:01 INFO - Running setup.py install for blessings 01:04:01 INFO - Successfully installed blessings 01:04:01 INFO - Cleaning up... 01:04:01 INFO - Return code: 0 01:04:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:01 INFO - Reading from file tmpfile_stdout 01:04:01 INFO - Current package versions: 01:04:01 INFO - argparse == 1.2.1 01:04:01 INFO - blessings == 1.6 01:04:01 INFO - blobuploader == 1.2.4 01:04:01 INFO - docopt == 0.6.1 01:04:01 INFO - manifestparser == 1.1 01:04:01 INFO - mozInstall == 1.12 01:04:01 INFO - mozcrash == 0.17 01:04:01 INFO - mozdebug == 0.1 01:04:01 INFO - mozdevice == 0.48 01:04:01 INFO - mozfile == 1.2 01:04:01 INFO - mozhttpd == 0.7 01:04:01 INFO - mozinfo == 0.9 01:04:01 INFO - mozleak == 0.1 01:04:01 INFO - mozlog == 3.2 01:04:01 INFO - moznetwork == 0.27 01:04:01 INFO - mozprocess == 0.22 01:04:01 INFO - mozprofile == 0.28 01:04:01 INFO - mozrunner == 6.11 01:04:01 INFO - mozscreenshot == 0.1 01:04:01 INFO - mozsystemmonitor == 0.3 01:04:01 INFO - moztest == 0.7 01:04:01 INFO - mozversion == 1.4 01:04:01 INFO - psutil == 3.1.1 01:04:01 INFO - requests == 1.2.3 01:04:01 INFO - wsgiref == 0.1.2 01:04:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:01 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:04:01 INFO - Using env: {'DISPLAY': ':0', 01:04:01 INFO - 'HOME': '/home/cltbld', 01:04:01 INFO - 'LANG': 'en_US.UTF-8', 01:04:01 INFO - 'LANGUAGE': 'en_US:en', 01:04:01 INFO - 'LOGNAME': 'cltbld', 01:04:01 INFO - 'MAIL': '/var/mail/cltbld', 01:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:01 INFO - 'MOZ_NO_REMOTE': '1', 01:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:01 INFO - 'NO_EM_RESTART': '1', 01:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:01 INFO - 'PWD': '/builds/slave/test', 01:04:01 INFO - 'SHELL': '/bin/bash', 01:04:01 INFO - 'SHLVL': '1', 01:04:01 INFO - 'TERM': 'linux', 01:04:01 INFO - 'TMOUT': '86400', 01:04:01 INFO - 'USER': 'cltbld', 01:04:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:01 INFO - '_': '/tools/buildbot/bin/python'} 01:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:04:02 INFO - Cleaning up... 01:04:02 INFO - Return code: 0 01:04:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:04: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')]} 01:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04: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')]} 01:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:02 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 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:04:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:04:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:04:02 INFO - Using env: {'DISPLAY': ':0', 01:04:02 INFO - 'HOME': '/home/cltbld', 01:04:02 INFO - 'LANG': 'en_US.UTF-8', 01:04:02 INFO - 'LANGUAGE': 'en_US:en', 01:04:02 INFO - 'LOGNAME': 'cltbld', 01:04:02 INFO - 'MAIL': '/var/mail/cltbld', 01:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:02 INFO - 'MOZ_NO_REMOTE': '1', 01:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:02 INFO - 'NO_EM_RESTART': '1', 01:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:02 INFO - 'PWD': '/builds/slave/test', 01:04:02 INFO - 'SHELL': '/bin/bash', 01:04:02 INFO - 'SHLVL': '1', 01:04:02 INFO - 'TERM': 'linux', 01:04:02 INFO - 'TMOUT': '86400', 01:04:02 INFO - 'USER': 'cltbld', 01:04:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:02 INFO - '_': '/tools/buildbot/bin/python'} 01:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:02 INFO - Downloading/unpacking jsonschema 01:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:04:04 INFO - Downloading/unpacking functools32 (from jsonschema) 01:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:04:04 INFO - warning: no files found matching '*.txt' 01:04:04 INFO - no previously-included directories found matching 'build' 01:04:04 INFO - no previously-included directories found matching 'dist' 01:04:04 INFO - no previously-included directories found matching '.git*' 01:04:04 INFO - Installing collected packages: jsonschema, functools32 01:04:04 INFO - Running setup.py install for functools32 01:04:04 INFO - warning: no files found matching '*.txt' 01:04:04 INFO - no previously-included directories found matching 'build' 01:04:04 INFO - no previously-included directories found matching 'dist' 01:04:04 INFO - no previously-included directories found matching '.git*' 01:04:04 INFO - Successfully installed jsonschema functools32 01:04:04 INFO - Cleaning up... 01:04:04 INFO - Return code: 0 01:04:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc21e4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a66770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, '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': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:04:04 INFO - Using env: {'DISPLAY': ':0', 01:04:04 INFO - 'HOME': '/home/cltbld', 01:04:04 INFO - 'LANG': 'en_US.UTF-8', 01:04:04 INFO - 'LANGUAGE': 'en_US:en', 01:04:04 INFO - 'LOGNAME': 'cltbld', 01:04:04 INFO - 'MAIL': '/var/mail/cltbld', 01:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:04 INFO - 'MOZ_NO_REMOTE': '1', 01:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:04 INFO - 'NO_EM_RESTART': '1', 01:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:04 INFO - 'PWD': '/builds/slave/test', 01:04:04 INFO - 'SHELL': '/bin/bash', 01:04:04 INFO - 'SHLVL': '1', 01:04:04 INFO - 'TERM': 'linux', 01:04:04 INFO - 'TMOUT': '86400', 01:04:04 INFO - 'USER': 'cltbld', 01:04:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:04 INFO - '_': '/tools/buildbot/bin/python'} 01:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:04 INFO - Downloading/unpacking flake8 01:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:04:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:04:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:07 INFO - no previously-included directories found matching 'docs/_build' 01:04:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:04:07 INFO - Running setup.py install for pep8 01:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:04:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:04:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:04:07 INFO - no previously-included directories found matching 'docs/_build' 01:04:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:04:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:04:07 INFO - Cleaning up... 01:04:07 INFO - Return code: 0 01:04:07 INFO - Running post-action listener: _resource_record_post_action 01:04:07 INFO - Running post-action listener: _start_resource_monitoring 01:04:07 INFO - Starting resource monitoring. 01:04:07 INFO - ##### 01:04:07 INFO - ##### Finished create-virtualenv step (success) 01:04:07 INFO - ##### 01:04:07 INFO - ##### 01:04:07 INFO - ##### Running install step. 01:04:07 INFO - ##### 01:04:07 INFO - Running pre-action listener: _resource_record_pre_action 01:04:07 INFO - Running main action method: install 01:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:04:08 INFO - Reading from file tmpfile_stdout 01:04:08 INFO - Detecting whether we're running mozinstall >=1.0... 01:04:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:04:08 INFO - Reading from file tmpfile_stdout 01:04:08 INFO - Output received: 01:04:08 INFO - Usage: mozinstall [options] installer 01:04:08 INFO - Options: 01:04:08 INFO - -h, --help show this help message and exit 01:04:08 INFO - -d DEST, --destination=DEST 01:04:08 INFO - Directory to install application into. [default: 01:04:08 INFO - "/builds/slave/test"] 01:04:08 INFO - --app=APP Application being installed. [default: firefox] 01:04:08 INFO - mkdir: /builds/slave/test/build/application 01:04:08 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'] 01:04:08 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 01:04:24 INFO - Reading from file tmpfile_stdout 01:04:24 INFO - Output received: 01:04:24 INFO - /builds/slave/test/build/application/firefox/firefox 01:04:24 INFO - Running post-action listener: _resource_record_post_action 01:04:24 INFO - ##### 01:04:24 INFO - ##### Finished install step (success) 01:04:24 INFO - ##### 01:04:24 INFO - ##### 01:04:24 INFO - ##### Running run-tests step. 01:04:24 INFO - ##### 01:04:24 INFO - Running pre-action listener: _resource_record_pre_action 01:04:24 INFO - Running main action method: run_tests 01:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:04:24 INFO - Python 2.7.3 01:04:24 INFO - Return code: 0 01:04:24 INFO - grabbing minidump binary from tooltool 01:04: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')]} 01:04:24 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 0x2af59c0>, '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 0x2af68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:04:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:04:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:04:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:04:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:04:24 INFO - Return code: 0 01:04:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:04:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:04:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:04:25 INFO - Return code: 0 01:04:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:04:25 INFO - Using env: {'DISPLAY': ':0', 01:04:25 INFO - 'HOME': '/home/cltbld', 01:04:25 INFO - 'LANG': 'en_US.UTF-8', 01:04:25 INFO - 'LANGUAGE': 'en_US:en', 01:04:25 INFO - 'LOGNAME': 'cltbld', 01:04:25 INFO - 'MAIL': '/var/mail/cltbld', 01:04:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:04:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:25 INFO - 'MOZ_NO_REMOTE': '1', 01:04:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:25 INFO - 'NO_EM_RESTART': '1', 01:04:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:25 INFO - 'PWD': '/builds/slave/test', 01:04:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:04:25 INFO - 'SHELL': '/bin/bash', 01:04:25 INFO - 'SHLVL': '1', 01:04:25 INFO - 'TERM': 'linux', 01:04:25 INFO - 'TMOUT': '86400', 01:04:25 INFO - 'USER': 'cltbld', 01:04:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026', 01:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:25 INFO - '_': '/tools/buildbot/bin/python'} 01:04:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:04:25 INFO - mozversion application_buildid: 20160515223014 01:04:25 INFO - mozversion application_changeset: d0be57e84807ce0853b2406de7ff6abb195ac898 01:04:25 INFO - mozversion application_display_name: Nightly 01:04:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:04:25 INFO - mozversion application_name: Firefox 01:04:25 INFO - mozversion application_remotingname: firefox 01:04:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:04:25 INFO - mozversion application_vendor: Mozilla 01:04:25 INFO - mozversion application_version: 49.0a1 01:04:25 INFO - mozversion platform_buildid: 20160515223014 01:04:25 INFO - mozversion platform_changeset: d0be57e84807ce0853b2406de7ff6abb195ac898 01:04:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:04:25 INFO - mozversion platform_version: 49.0a1 01:04:25 INFO - using testdate: 1463385865 01:04:25 INFO - actual date: 1463385865 01:04:25 INFO - starting webserver on 'localhost:44527' 01:04:25 INFO - SUITE-START | Running 2 tests 01:04:25 INFO - TEST-START | dromaeo_css 01:04:25 INFO - operating with platform_type : linux_ 01:04:25 INFO - Initialising browser for dromaeo_css test... 01:04:25 INFO - TEST-INFO | started process 23401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCmwDa/profile http://localhost:44527/getInfo.html) 01:04:30 INFO - PROCESS | 23401 | __metrics Screen width/height:1600/1200 01:04:30 INFO - PROCESS | 23401 | colorDepth:24 01:04:30 INFO - PROCESS | 23401 | Browser inner width/height: 1024/697 01:04:30 INFO - PROCESS | 23401 | __metrics 01:04:31 ERROR - PROCESS | 23401 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:04:32 INFO - TEST-INFO | 23401: exit 0 01:04:32 INFO - Browser initialized. 01:04:32 INFO - Running cycle 1/1 for dromaeo_css test... 01:04:32 INFO - TEST-INFO | started process 23481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmCmwDa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:04:43 INFO - PROCESS | 23481 | RSS: Main: 152121344 01:04:43 INFO - PROCESS | 23481 | 01:05:34 INFO - PROCESS | 23481 | 1463385934995 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:07:42 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44527/tests/dromaeo/cssquery-ext.html) 01:07:44 INFO - PROCESS | 23481 | RSS: Main: 276127744 01:07:44 INFO - PROCESS | 23481 | 01:10:46 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-ext.html (next: http://localhost:44527/tests/dromaeo/cssquery-jquery.html) 01:10:46 INFO - PROCESS | 23481 | RSS: Main: 234332160 01:10:46 INFO - PROCESS | 23481 | 01:13:48 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44527/tests/dromaeo/cssquery-mootools.html) 01:13:49 INFO - PROCESS | 23481 | RSS: Main: 248082432 01:13:49 INFO - PROCESS | 23481 | 01:16:51 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44527/tests/dromaeo/cssquery-prototype.html) 01:16:51 INFO - PROCESS | 23481 | RSS: Main: 229597184 01:16:51 INFO - PROCESS | 23481 | 01:19:54 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44527/tests/dromaeo/cssquery-yui.html) 01:19:55 INFO - PROCESS | 23481 | RSS: Main: 222109696 01:19:55 INFO - PROCESS | 23481 | 01:22:57 INFO - PROCESS | 23481 | Cycle 1(1): loaded http://localhost:44527/tests/dromaeo/cssquery-yui.html (next: http://localhost:44527/tests/dromaeo/cssquery-dojo.html) 01:22:58 INFO - PROCESS | 23481 | RSS: Main: 257593344 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | __start_tp_report 01:22:58 INFO - PROCESS | 23481 | _x_x_mozilla_page_load 01:22:58 INFO - PROCESS | 23481 | _x_x_mozilla_page_load_details 01:22:58 INFO - PROCESS | 23481 | |i|pagename|runs| 01:22:58 INFO - PROCESS | 23481 | |0;dojo.html;3130.34262804811;3159.778815482914;3176.9205769855753;3193.345364200339;3210.293735378216;5223.347081614798;5265.9473405265935;5355.357357117146;5432.8913421731595;5469.425710300421;5326.201069839526;5347.358317001956;5349.732513374335;5363.919541206885;5372.194170874371;4798.640101992356;4818.87952801181;4934.185859333205;4950.3069570260195;4986.401631804189;4925.138100832358;4936.333594964688;4988.850334489971;4993;5001.17480615698;4767.737774422405;4892.755362231892;4941.950580494185;4954.925676114861;4960.181570040939;4945.208766597327;4959.280904268897;4967.205247160437;4973.7513124344;5021.121303771825;4722.315264286659;4919.827806026808;4934.679245849008;4948.084604348207;5018.2974383586325;5186.170212765977;5201.037808005493;5225.634205605609;5284.5243928046275;5314.92027619586;5659;5715.657060576379;5715.685637289947;5723.9141412878425;5735.082386818089;5670.914936275959;5728.5417166626985;5729.5702822288495;5732.770689172428;5737.512311453532;5388.084025715638;5469.371022332443;5485.314335708036;5493.752781124819;5498.065328894098;5987.760489580455;6004.399560044048;6004.579679422399;6005.069214271794;6010.489108425745;5517;5583.469570390806;5596.132599447093;5744.281964754406;5744.310682718101;5760.135979603093;5766.4233576642;5766.88466230673;5777.306723193244;5802.709864506758;5699.344575373802;5707.686077265707;5729.598928075078;5746.741396637078;5747.597668163272;5471.288732464834;5684.317881854121;5688.77244910199;5697.116946873241;5722.113072473773;4400.405945197422;4401.911961760747;4402.163588918095;4404.889877753082;4435.35687325336;3890.902727431837;3909.4722212500947;3920.157166209279;3959.0696186396176;3973.8013099344917;5347.679139251657;5395.379531353866;5461.836144915659;5474.671519708751;5509.559235261169;5809.8547536311935;5839.328477225088;5854.8536286592325;5860.882782344329;5861.120831875252;5539.584531160179;5547.41752116022;5547.417521160301;5550.861228469321;5554.944450555524;4884.194107972145;4924.581410580069;4940.481249468754;4944.60443164546;4952.876178095505;5947.702614869239;5966.105084237399;5971.940280597139;5972.910406343908;5973.910391344133;5772.5959182856795;5777.3933736957015;5782.479576838105;5783.94216057834;5786.189933409242;5732.111522713986;5836.445537674084;5844.883102338014;5948.643081415129;5955.910661339996;5605.719714014202;5623.381428042994;5655.321361436654;5660.85847853807;5728.8567785804025;5801.274840644919;5818.4763371296785;5819.5344372450945;5823.4176582343125;5825.679587622722;5398.946010539844;5641.605087643826;5644.040513112698;5661.348944871393;5664.830055098354;5573.944260557342;5598.300212473441;5624.128260119688;5690.231818704588;5699.629524080921;5522.723863806874;5561.193626923992;5571.526420254162;5601.887962240814;5616.466435688603;5519.641223320471;5589.469000444951;5702.45826646468;5707.942920570741;5744.13837924298;5500.58745594074;5537.944620553743;5539.307586551681;5546.251256080377;5593.664380137205 01:22:58 INFO - PROCESS | 23481 | |1;ext.html;601;628.3402427451176;645.2837350540901;655.8229278094915;659.9241087274964;42602.36096458552;43851.12297754043;43874.12251754967;43942.780286098525;47089.29366059512;45255.77372113143;45656.3151552727;45974.77012614932;46012.769936150275;46016.539834601725;8911.376203665763;8979.730608081769;9012.324075694349;9060.682876099338;9063.546822658873;8906.064863189336;8990.190882820545;8993.505357205351;9000.369974101815;9001.369904106716;9083.364164508486;9113.95443022784;9121.224695900857;9122.407043542182;9126.498042607654;9021.233195178418;9050.909490905138;9059.547022648907;9064.18422341989;9066.863997040049;8901.42140760855;8966.910330896673;8971.955140224323;8974.237189838872;8977.865332020025;42854.78572607148;43167.78416107899;43211.78394108041;43369.78315108436;43443.565564344266;3544.3442963051916;3678.8160591970563;3738.9813050934845;4000.7599544027453;4419.779011049467;33054.33891322184;33183;33646.1588460288;33652;33725.15687107817;3805.9429108563395;3830.9616903830884;3886.3587508061137;3917.4319723640197;3923.156521347924;371704;373806;374139;375595;376710;53283;54288;58848.70575647095;61443.38556614376;61829.690851545456;60953.390466094774;65278;65414.34585654082;65665.34334656688;65700.34299657038;16372.263248153862;16595.50213493597;16629.50111496657;16644.58388540296;16654.75017874733;11220.719482012852;11772.529098836121;11782.469788859522;12466.626001219978;12713.173643713313;19374.321898733477;19500.082108751525;19512.219511219675;19517.034407808784;19554.413367598994;7299.5620262784405;7369.668364923591;7403.444741644398;7442.776716698508;7547.50941188821;983.7098056073476;1053.878803937557;1054.3726482742757;1140.406988366045;1150.764093360859;32186.19534511609;32577.674223257465;32757.508637370458;32819.22148777657;32903.3419331612;1138.9316641001567;1147.6614398752388;1163.1973937982934;1192.070185255502;1197.6047904191596;16534.6693066138;17155.485335439957;17162.656746864992;17215.65568688619;17311.826881731275;601040;601286;604876;605507;605579;57024.42975570191;57499.42500575024;57803.421965780646;57873.710631447415;57882.42117578854;1397.1617029782049;1414.0384538513704;1414.2716501001992;1423.4946593958996;1442.1995792335144;30916;31150.221244468165;31729;31816.204594885312;32280.838595806872;50421.74789126031;50738.49261507337;50865.237021443965;50890;50908.74545627248;446851;454719;456507;457105;485110;27508.44983100367;28064.737086830733;28148.577771333035;28204.71795282103;29346.413071738018;44961.32558011698;48717.26924096212;48962.26556601725;49559.256611151584;50016;40401.595984039785;41162.65970120929;41274;41874.37188442237;42393.788031059645;40591.39112913368;40777.79611102044;40858;41160.38259426051;41338.58661413468;40967;41543;42056.158876822905;42183;44473.33290000588;34493.65506344904;36616.26767464689;37512.624873750916;37757;37828.24343513059;28388.5968660257;28632.284192894513;28917.890864377652;29007.7099229005;29040 01:22:58 INFO - PROCESS | 23481 | |2;jquery.html;407.3523098273746;414.1323926374245;414.7552943763179;414.890054135654;424.9107687385649;13582.388792504336;18056;19486.902565487188;19658;19677.803221967795;14692.632684182901;17392.47822565322;17542.64914701705;18164.727529087075;18372.35696750614;5789.884202315951;5902.085176797603;5927.110933360009;5933.376995415484;5980.671063091529;5855.443732845394;5904.084866845646;5933.910991335133;5944.762209511614;5955.255593050869;4221.936670949938;6078.118672792442;6363;6373.330800265975;6567.113439685629;6444.162258906359;6528.6409247491365;6536.673166341688;6561.2782593914635;6571.539992200548;5594.384617692051;5699.173619825144;5718.142278658193;5730.7707691692285;5741.712914354265;22499.887500562556;22776.20283290077;22788.430289242737;23192.30423087293;23854.403639908967;2358.4457652451833;2444.083468699238;2467.6668649732237;2469.790067844235;2638.5514462541223;13783.173009619455;14312.713745725132;14389.424423023067;14626.780598291034;15256.084634921941;1976.8418526517844;1994.7706013808452;2017.515796208914;2034.5527449136268;2106.273335699181;84334;84551.5772421134;85547;86247.56876215641;87135;10757.946210269056;10916.67249982486;11076.612318568812;11107.944460277648;11188.216824822184;15445.227738613024;15585.064896106043;15597.68804623901;15600.29798659063;15612.76580851288;8074.515529068275;8426.873596896052;8434.62044208012;8534.487930724177;8549.401541892008;7991.8401631967035;8083.19168083187;8083.393745469113;8185.3042491387705;8213.219744124299;6062.302835173923;6471.5146364022885;6704.363085506967;6732.124823772878;6860.245373008965;1825.195220622816;1916;1973.8716983396034;1981.127834196699;2006.959860802805;996.5963784667222;1039.8440233964966;1075.8327214971687;1093.3112139352156;1094.2887123369715;19331.226750930087;19692.803071969385;19906.104225309897;20013.199472020955;20116.29592964239;1027.3784360461962;1048.9790204196026;1062.3254233561745;1082.4154956323655;1085.403028334413;9598.520073996273;11623;11643.243189192845;11658.88341116578;11670.183087183816;456795;464847;469343;469398;473425;55272.72363638156;82679;84258;85111.5744421274;85703.57148214344;1043.3791893823163;1060.2366296266675;1071.196602548089;1076.036946932491;1081.432248069754;17309.701772367374;17607.20767565437;17839.732404013692;17871.28514859391;18135.27458901682;38296.2340753189;38510.22979540337;39427;40257.59742402656;40971.59028409797;51423.74288128685;52952.73523632357;53415.46584534105;53468.73265633647;53791;8755.605997730245;8936.910630893868;9046.140616641409;9111.954440227757;9207.079292070739;13306.534271300845;13858.930705346409;13863.376148073563;14024.158550487004;14084.295785210903;11827.763444731228;11940.402979851146;12070.637880863587;12073.879261207276;12544.121911466109;10404.791904162026;11804.881951180721;11813.586524471602;11900.35842651265;12124.333161676192;12077.51689932393;12081.57714479989;12099.455524501594;12321.876781232073;12347.814782778445;8610.913890861011;8747.562146696764;8894.688685895962;9093.818123637358;9114;12016.218945768496;12079.637610871689;12303.44634491432;12306.630801075982;12374.566890158801 01:22:58 INFO - PROCESS | 23481 | |3;mootools.html;1282.48059535888;1402.5371627362972;1491.090434834751;1521.4142555116277;1665.209025712786;8697.478151310917;9029.367944243897;9053.592588333524;9300.767480812983;9302.069793020695;8890.066543012988;9114.270858331334;9125.771855703611;9127.771805704844;9148.954255228731;2320.025589252514;2344.4724936889234;2344.554534638422;2345.2260753951155;2345.683332750074;2409.8433601815827;2442.1940759549307;2444.584420648494;2448.571499987504;2451.0318424222423;2374.192774456684;2384.7138343398815;2395.9520809583887;2400.6759087523137;2413.963790543143;2251.1333136742473;2264.467850055236;2266.5580211858696;2273.954520909581;2284.9200277990276;2256.1539422716482;2258.1757658454544;2258.706368172127;2263.4793997380693;2264.3320220534815;8898.777530561723;8999.730008099768;9079.500627465486;9092.499737543298;9123.361364704473;5365.839024829262;5520.447955204488;5524.972375138099;5525.502704756551;5528.668279903179;3440.9483857742152;3506.736994725406;3536.664016918389;3558.466230065485;3567.4827150063097;1091.1925175370247;1112.6606385052555;1127.6335191062938;1146.9254498457574;1149.2702134144795;13035.283059431727;13152.079354445194;13153.86846131536;13160.210387376788;13161.341932903413;4553.33976573395;4626.1726617985705;4661.953380466152;4707.95292047082;4722.504137065627;10230.539625716712;10298.948505257425;10300.896991029993;10307.123894468905;10330.586776528855;5374.785008599691;5378.408375078739;5381.3811411687375;5382.1119515280325;5387.6228663993925;4358.084802191512;4742.715437073718;4920.901581968412;4931;4957.925631115536;3874.8256328465286;3902.687784977195;3936.075022369741;3978.4430179774854;3982.104026594051;1207.8007128823822;1212.1454374665839;1224.8285240066398;1236.8577613574555;1246.9064820138526;735.3455424671939;944.3153713557753;987.9308448408686;989.9406035637885;1002.5789168549227;5829.59192856496;5984.670843103584;6091.725872335755;6097.756089756449;6152.692365381713;981.1513041219293;1020.4030642074321;1049.8267785815256;1102.7904698107495;1102.795982743195;4099.057216840143;4199.559046300155;4200.831966721297;4208.684348673862;4224.471941007374;11373.886261137448;11544.826827597593;11584.652460426201;11587.188896777145;11617.302961822317;10978.780424391627;11663.475143618558;11734.765304693858;11782.234154779911;11814.409279535988;8289.212524810133;8649.178328058699;8681.524140896063;8746.781330466662;8750.51872147038;6124.8775024500155;6223.751049957951;6312.495000400048;6371.745130194926;6510.283868774336;10663.306885052447;10757.946210269212;10771.19216058783;10873.293235939638;10897.782044359226;10795.406252655865;11034.889651103385;11106.111511079256;11185.384803835866;11198.44007799623;7324.926750732425;7786.532808031537;7886.211378862068;7968.203179681986;8030.277275045274;8913;8929.06244844282;8963.910360896569;8974.37179397462;9010.729678109667;7894.289513943772;8084.029916410069;8121.959390203011;8181.877271840808;8192.016957964845;7749.651265692944;7905.802354941173;7921.722739704082;7961.6019199040975;8065.274125328749;6987.336203060701;7003.1596208453275;7048.013278140962;7072.68172932209;7076.575405475688;5272.156454967187;5274.762635681327;5354.3574771027725;5381.542568881689;5396.892062158657;5165.044466773659;5243.108671525773;5332.906754115319;5369.1140961740875;5401.756920938488 01:22:58 INFO - PROCESS | 23481 | |4;prototype.html;331.2166725693735;339.5500961226374;340.24465686176677;342.29828850855745;349.0958417698161;5349.358077030757;5352.170413585891;5375.75809088591;5412.566994640424;5417.972910135449;5066.417362003371;5118.3640425180965;5210.713410762407;5246.501582349681;5345.224942383362;4117.114820313632;4154.750714957097;4165.708400411972;4168.416421700949;4188.937165942506;4189.245935731567;4193.370994350857;4202.222588821078;4205.663546916239;4209.684273679471;3980.7412518186225;4002.979240293721;4162.854300099497;4172.415861779354;4188.246115699173;4137.855175068858;4145;4155.33514637658;4163.958360416387;4165.354370072643;3718.1819999600043;3721.3673675475234;3732.085639018431;3743.5320584926885;3753.9436908446396;5058.241263810458;5082.390113186404;5092.592592592584;5114.769835357418;5211.557017653504;4713.316569097496;4727.574518293336;4731.124741922756;4734.597559207472;4743.976280118612;5483.341998960111;5485.6982865942755;5508.338999320107;5531.889362212773;5546.69493177875;3982.283189025974;4048.1498885234137;4050.2709512287774;4057.8173982170874;4090.1001779608437;5651.8304450866535;5659.7453114609525;5683.953776640406;5690.146478028288;5706.343770466367;4119.855805046809;4142.150859073882;4151.6886233532605;4152.522459917088;4176.519700234451;4046.959530404717;4196.664266858644;4219.430376899079;4223.627321120648;4249.597632781175;4732.337472753818;4765.642576806753;4771.904561908743;4782.206672497813;4786.377770889762;5541.362743284493;5567.995521612216;5607.504660426152;5615.578831587647;5618.247058941171;1403.4947418929178;1408.7252985667697;1434.6771976305247;1452.4771082410323;1455.3087283540444;877.3376101043799;891.3225948279354;893.1559676106148;1010.141379827141;1027.8098551767798;5303.390110137384;5343.7060961647485;5360.839174824761;5361.142217245222;5385.219143224211;5557.221988921554;5663.555793272689;5675.517581005661;5679.432056794288;5688.48803607669;5358.571314294925;5372.7313634318125;5385.299911011543;5386.703731294817;5393.2179833923865;2953.8227706337257;2967.703229677058;2972.212363723615;2977.211039074604;2984.268854130752;5547.2511210986;5800.854978625483;5816.47651711348;5819.912701309484;5847.210626565445;5725.625849796019;5727.140928860621;5734.885302293931;5736.799212027559;5748.815450128925;5774.653520788598;5787.276590426281;5814.796482123105;5829.8251052468495;5832.591718579743;5431.293931788842;5755.539556835527;5758.568107391879;5769.567282453749;5774.191613174243;5670.603057785916;5674.900286893876;5692.800751973661;5704.771809127588;5739.30690446311;5722.456366645162;5925.585209035326;5931.495822854933;5946.375630558729;5979.5814292999075;4159.625633692982;4163.916721665611;4172.561881002573;4191.97904010478;4201.45381100455;5679.602427830012;5704.716438801236;5755.683437410982;5756.683382414008;5782.363939966516;5415.756290966837;5552.7778888843995;5552.972235138798;5560.582956278215;5620.85947851307;5495.835124946258;5506.760978779743;5537.972310138423;5559.805406810742;5571.582131340247;5272.736363181903;5302.761375738024;5435.565154787687;5442.319710036246;5525.171224316385;5563.388027317073;5581.7209139543675;5590.630295577609;5608.943910561005;5619.100943849128;5199.92200116991;5417.322834645669;5500.28496295479;5516.393196748274;5516.779328826802 01:22:58 INFO - PROCESS | 23481 | |5;yui.html;730.736934703507;788.1921030943282;835.9582020898954;873.9737807865766;887.915648013439;14430.134191948464;14894.776578351333;15080.622984425394;15245.466408675698;15256.69486610267;13162.07865449419;13314.201147931131;13331.866681333184;13332.200067995902;13350.132241404302;702.220535205921;816.1389733830806;828.3000864269698;840.8822764812932;841.1714461255658;836.9330453563731;837.794740288627;839.1147339556766;839.559231403512;840.6175190288404;868.2186032570673;868.431177578687;869.1699427047155;869.3827382558391;869.678219058946;713.9607321597337;847.7414388611502;859.4113032572676;862.9093945135796;864.3171894203572;641.4002907281659;642.0369445831253;642.1202951955851;642.2197030607834;642.4314481683743;14424.206668633222;14448.277586120757;14477.493287734984;14481.493147739779;14503.41986320546;13658.453661853513;13865.861341386559;14095.436182552685;14133.363998620087;14290.857091429056;11761.823572646417;11979.221350612183;12037.578684746079;12228.938855305667;12245.632631021084;4425.491068527129;4443.178012067778;4507.414036175309;4623.029163875556;4624.260118381077;57403.71298143482;57499.71250143764;57506;57774.71112644494;57875;10030.197584193247;10500.474976251156;10713.89286107129;11413.657590272305;11463.484143213574;18739.34412295563;18921.81078189228;19776.40670779879;19797.60404791925;19800.821909589933;8484.32125429964;8594.183552562497;8598.484090954562;8694.347923905732;8729.781755456164;4833.951660483421;4885.096257192431;4914.5822605078965;4951.851444456672;4964.081644895706;3319.336132773455;3440.724742020632;3503.8598456061472;3512.631173726722;3526.083218363193;582.3361368040437;601.5458328961606;652.8008957267983;653.3792896748108;659.5844617890698;638.2596188421409;724.5037149552574;791.4538968111984;803.4857691077715;804.8913396691489;9663.613455461844;9671.419714817133;9693;9740.95129524362;9890.65382711616;680.4794332335767;689.2452764223168;702.8067281497629;732.0885497555578;753.9924600754032;4511.8646440606835;4582.908341833211;4587.1513769952;4616.976915115403;4621.630269578425;73585.26414735892;75610.6219468899;75621.24378756252;75844.62077689686;76259;66819.66590167017;66920.33079669239;68478.65760671165;69871.3012869875;70211.64894175496;63296.683516582125;63466;63536;63573.36426635767;64060;8804.339674524308;8819;8863.601137948679;8905.243054340453;9153.221976132103;38618;39975.60024399835;40245.79877100596;40753.796231018656;40999.59000410077;45623.77188114038;45920;51708.48291517187;55044.724776377465;55533;11727.882721172678;12550.49798008106;12610.558630447891;12655.430505627084;12744.753253057434;13326.466941322238;13461.730765384833;13964.371603277674;14316.928415357857;14666.706665866835;12623.621291360907;12636.30500322491;12845.871541284841;13240.337983100613;13268.734625307246;11982.10134239918;12010.219335743148;12015.519379224734;12019.75960480803;12384.380780960735;12208.694782630506;12258.14193006481;12530.624081277576;12551.3096779678;12657.93671031639;10929.56281748753;11398.145139114433;11440.885591143982;11444.370559619301;11464.885351146715;10355.585776568852;10580.532691488661;10834.945825270823;10846.29499082557;10884.782304354027 01:22:58 INFO - PROCESS | 23481 | __end_tp_report 01:22:58 INFO - PROCESS | 23481 | __start_cc_report 01:22:58 INFO - PROCESS | 23481 | _x_x_mozilla_cycle_collect,1010 01:22:58 INFO - PROCESS | 23481 | __end_cc_report 01:22:58 INFO - PROCESS | 23481 | __startTimestamp1463386978174__endTimestamp 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | ------- Summary: start ------- 01:22:58 INFO - PROCESS | 23481 | Number of tests: 6 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#0] dojo.html Cycles:165 Average:5353.13 Median:5550.86 stddev:598.78 (10.8%) stddev-sans-first:574.67 01:22:58 INFO - PROCESS | 23481 | Values: 3130.3 3159.8 3176.9 3193.3 3210.3 5223.3 5265.9 5355.4 5432.9 5469.4 5326.2 5347.4 5349.7 5363.9 5372.2 4798.6 4818.9 4934.2 4950.3 4986.4 4925.1 4936.3 4988.9 4993.0 5001.2 4767.7 4892.8 4942.0 4954.9 4960.2 4945.2 4959.3 4967.2 4973.8 5021.1 4722.3 4919.8 4934.7 4948.1 5018.3 5186.2 5201.0 5225.6 5284.5 5314.9 5659.0 5715.7 5715.7 5723.9 5735.1 5670.9 5728.5 5729.6 5732.8 5737.5 5388.1 5469.4 5485.3 5493.8 5498.1 5987.8 6004.4 6004.6 6005.1 6010.5 5517.0 5583.5 5596.1 5744.3 5744.3 5760.1 5766.4 5766.9 5777.3 5802.7 5699.3 5707.7 5729.6 5746.7 5747.6 5471.3 5684.3 5688.8 5697.1 5722.1 4400.4 4401.9 4402.2 4404.9 4435.4 3890.9 3909.5 3920.2 3959.1 3973.8 5347.7 5395.4 5461.8 5474.7 5509.6 5809.9 5839.3 5854.9 5860.9 5861.1 5539.6 5547.4 5547.4 5550.9 5554.9 4884.2 4924.6 4940.5 4944.6 4952.9 5947.7 5966.1 5971.9 5972.9 5973.9 5772.6 5777.4 5782.5 5783.9 5786.2 5732.1 5836.4 5844.9 5948.6 5955.9 5605.7 5623.4 5655.3 5660.9 5728.9 5801.3 5818.5 5819.5 5823.4 5825.7 5398.9 5641.6 5644.0 5661.3 5664.8 5573.9 5598.3 5624.1 5690.2 5699.6 5522.7 5561.2 5571.5 5601.9 5616.5 5519.6 5589.5 5702.5 5707.9 5744.1 5500.6 5537.9 5539.3 5546.3 5593.7 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#1] ext.html Cycles:180 Average:63795.28 Median:42288.39 stddev:129948.70 (307.3%) stddev-sans-first:130226.62 01:22:58 INFO - PROCESS | 23481 | Values: 601.0 628.3 645.3 655.8 659.9 42602.4 43851.1 43874.1 43942.8 47089.3 45255.8 45656.3 45974.8 46012.8 46016.5 8911.4 8979.7 9012.3 9060.7 9063.5 8906.1 8990.2 8993.5 9000.4 9001.4 9083.4 9114.0 9121.2 9122.4 9126.5 9021.2 9050.9 9059.5 9064.2 9066.9 8901.4 8966.9 8972.0 8974.2 8977.9 42854.8 43167.8 43211.8 43369.8 43443.6 3544.3 3678.8 3739.0 4000.8 4419.8 33054.3 33183.0 33646.2 33652.0 33725.2 3805.9 3831.0 3886.4 3917.4 3923.2 371704.0 373806.0 374139.0 375595.0 376710.0 53283.0 54288.0 58848.7 61443.4 61829.7 60953.4 65278.0 65414.3 65665.3 65700.3 16372.3 16595.5 16629.5 16644.6 16654.8 11220.7 11772.5 11782.5 12466.6 12713.2 19374.3 19500.1 19512.2 19517.0 19554.4 7299.6 7369.7 7403.4 7442.8 7547.5 983.7 1053.9 1054.4 1140.4 1150.8 32186.2 32577.7 32757.5 32819.2 32903.3 1138.9 1147.7 1163.2 1192.1 1197.6 16534.7 17155.5 17162.7 17215.7 17311.8 601040.0 601286.0 604876.0 605507.0 605579.0 57024.4 57499.4 57803.4 57873.7 57882.4 1397.2 1414.0 1414.3 1423.5 1442.2 30916.0 31150.2 31729.0 31816.2 32280.8 50421.7 50738.5 50865.2 50890.0 50908.7 446851.0 454719.0 456507.0 457105.0 485110.0 27508.4 28064.7 28148.6 28204.7 29346.4 44961.3 48717.3 48962.3 49559.3 50016.0 40401.6 41162.7 41274.0 41874.4 42393.8 40591.4 40777.8 40858.0 41160.4 41338.6 40967.0 41543.0 42056.2 42183.0 44473.3 34493.7 36616.3 37512.6 37757.0 37828.2 28388.6 28632.3 28917.9 29007.7 29040.0 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#2] jquery.html Cycles:180 Average:28182.40 Median:22990.37 stddev:76806.71 (334.1%) stddev-sans-first:76993.85 01:22:58 INFO - PROCESS | 23481 | Values: 407.4 414.1 414.8 414.9 424.9 13582.4 18056.0 19486.9 19658.0 19677.8 14692.6 17392.5 17542.6 18164.7 18372.4 5789.9 5902.1 5927.1 5933.4 5980.7 5855.4 5904.1 5933.9 5944.8 5955.3 4221.9 6078.1 6363.0 6373.3 6567.1 6444.2 6528.6 6536.7 6561.3 6571.5 5594.4 5699.2 5718.1 5730.8 5741.7 22499.9 22776.2 22788.4 23192.3 23854.4 2358.4 2444.1 2467.7 2469.8 2638.6 13783.2 14312.7 14389.4 14626.8 15256.1 1976.8 1994.8 2017.5 2034.6 2106.3 84334.0 84551.6 85547.0 86247.6 87135.0 10757.9 10916.7 11076.6 11107.9 11188.2 15445.2 15585.1 15597.7 15600.3 15612.8 8074.5 8426.9 8434.6 8534.5 8549.4 7991.8 8083.2 8083.4 8185.3 8213.2 6062.3 6471.5 6704.4 6732.1 6860.2 1825.2 1916.0 1973.9 1981.1 2007.0 996.6 1039.8 1075.8 1093.3 1094.3 19331.2 19692.8 19906.1 20013.2 20116.3 1027.4 1049.0 1062.3 1082.4 1085.4 9598.5 11623.0 11643.2 11658.9 11670.2 456795.0 464847.0 469343.0 469398.0 473425.0 55272.7 82679.0 84258.0 85111.6 85703.6 1043.4 1060.2 1071.2 1076.0 1081.4 17309.7 17607.2 17839.7 17871.3 18135.3 38296.2 38510.2 39427.0 40257.6 40971.6 51423.7 52952.7 53415.5 53468.7 53791.0 8755.6 8936.9 9046.1 9112.0 9207.1 13306.5 13858.9 13863.4 14024.2 14084.3 11827.8 11940.4 12070.6 12073.9 12544.1 10404.8 11804.9 11813.6 11900.4 12124.3 12077.5 12081.6 12099.5 12321.9 12347.8 8610.9 8747.6 8894.7 9093.8 9114.0 12016.2 12079.6 12303.4 12306.6 12374.6 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#3] mootools.html Cycles:180 Average:6013.64 Median:4455.71 stddev:3503.66 (78.6%) stddev-sans-first:3495.45 01:22:58 INFO - PROCESS | 23481 | Values: 1282.5 1402.5 1491.1 1521.4 1665.2 8697.5 9029.4 9053.6 9300.8 9302.1 8890.1 9114.3 9125.8 9127.8 9149.0 2320.0 2344.5 2344.6 2345.2 2345.7 2409.8 2442.2 2444.6 2448.6 2451.0 2374.2 2384.7 2396.0 2400.7 2414.0 2251.1 2264.5 2266.6 2274.0 2284.9 2256.2 2258.2 2258.7 2263.5 2264.3 8898.8 8999.7 9079.5 9092.5 9123.4 5365.8 5520.4 5525.0 5525.5 5528.7 3440.9 3506.7 3536.7 3558.5 3567.5 1091.2 1112.7 1127.6 1146.9 1149.3 13035.3 13152.1 13153.9 13160.2 13161.3 4553.3 4626.2 4662.0 4708.0 4722.5 10230.5 10298.9 10300.9 10307.1 10330.6 5374.8 5378.4 5381.4 5382.1 5387.6 4358.1 4742.7 4920.9 4931.0 4957.9 3874.8 3902.7 3936.1 3978.4 3982.1 1207.8 1212.1 1224.8 1236.9 1246.9 735.3 944.3 987.9 989.9 1002.6 5829.6 5984.7 6091.7 6097.8 6152.7 981.2 1020.4 1049.8 1102.8 1102.8 4099.1 4199.6 4200.8 4208.7 4224.5 11373.9 11544.8 11584.7 11587.2 11617.3 10978.8 11663.5 11734.8 11782.2 11814.4 8289.2 8649.2 8681.5 8746.8 8750.5 6124.9 6223.8 6312.5 6371.7 6510.3 10663.3 10757.9 10771.2 10873.3 10897.8 10795.4 11034.9 11106.1 11185.4 11198.4 7324.9 7786.5 7886.2 7968.2 8030.3 8913.0 8929.1 8963.9 8974.4 9010.7 7894.3 8084.0 8122.0 8181.9 8192.0 7749.7 7905.8 7921.7 7961.6 8065.3 6987.3 7003.2 7048.0 7072.7 7076.6 5272.2 5274.8 5354.4 5381.5 5396.9 5165.0 5243.1 5332.9 5369.1 5401.8 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#4] prototype.html Cycles:180 Average:4688.19 Median:5360.99 stddev:1363.62 (25.4%) stddev-sans-first:1327.66 01:22:58 INFO - PROCESS | 23481 | Values: 331.2 339.6 340.2 342.3 349.1 5349.4 5352.2 5375.8 5412.6 5418.0 5066.4 5118.4 5210.7 5246.5 5345.2 4117.1 4154.8 4165.7 4168.4 4188.9 4189.2 4193.4 4202.2 4205.7 4209.7 3980.7 4003.0 4162.9 4172.4 4188.2 4137.9 4145.0 4155.3 4164.0 4165.4 3718.2 3721.4 3732.1 3743.5 3753.9 5058.2 5082.4 5092.6 5114.8 5211.6 4713.3 4727.6 4731.1 4734.6 4744.0 5483.3 5485.7 5508.3 5531.9 5546.7 3982.3 4048.1 4050.3 4057.8 4090.1 5651.8 5659.7 5684.0 5690.1 5706.3 4119.9 4142.2 4151.7 4152.5 4176.5 4047.0 4196.7 4219.4 4223.6 4249.6 4732.3 4765.6 4771.9 4782.2 4786.4 5541.4 5568.0 5607.5 5615.6 5618.2 1403.5 1408.7 1434.7 1452.5 1455.3 877.3 891.3 893.2 1010.1 1027.8 5303.4 5343.7 5360.8 5361.1 5385.2 5557.2 5663.6 5675.5 5679.4 5688.5 5358.6 5372.7 5385.3 5386.7 5393.2 2953.8 2967.7 2972.2 2977.2 2984.3 5547.3 5800.9 5816.5 5819.9 5847.2 5725.6 5727.1 5734.9 5736.8 5748.8 5774.7 5787.3 5814.8 5829.8 5832.6 5431.3 5755.5 5758.6 5769.6 5774.2 5670.6 5674.9 5692.8 5704.8 5739.3 5722.5 5925.6 5931.5 5946.4 5979.6 4159.6 4163.9 4172.6 4192.0 4201.5 5679.6 5704.7 5755.7 5756.7 5782.4 5415.8 5552.8 5553.0 5560.6 5620.9 5495.8 5506.8 5538.0 5559.8 5571.6 5272.7 5302.8 5435.6 5442.3 5525.2 5563.4 5581.7 5590.6 5608.9 5619.1 5199.9 5417.3 5500.3 5516.4 5516.8 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - PROCESS | 23481 | [#5] yui.html Cycles:180 Average:16458.22 Median:4623.64 stddev:20488.64 (443.1%) stddev-sans-first:20512.08 01:22:58 INFO - PROCESS | 23481 | Values: 730.7 788.2 836.0 874.0 887.9 14430.1 14894.8 15080.6 15245.5 15256.7 13162.1 13314.2 13331.9 13332.2 13350.1 702.2 816.1 828.3 840.9 841.2 836.9 837.8 839.1 839.6 840.6 868.2 868.4 869.2 869.4 869.7 714.0 847.7 859.4 862.9 864.3 641.4 642.0 642.1 642.2 642.4 14424.2 14448.3 14477.5 14481.5 14503.4 13658.5 13865.9 14095.4 14133.4 14290.9 11761.8 11979.2 12037.6 12228.9 12245.6 4425.5 4443.2 4507.4 4623.0 4624.3 57403.7 57499.7 57506.0 57774.7 57875.0 10030.2 10500.5 10713.9 11413.7 11463.5 18739.3 18921.8 19776.4 19797.6 19800.8 8484.3 8594.2 8598.5 8694.3 8729.8 4834.0 4885.1 4914.6 4951.9 4964.1 3319.3 3440.7 3503.9 3512.6 3526.1 582.3 601.5 652.8 653.4 659.6 638.3 724.5 791.5 803.5 804.9 9663.6 9671.4 9693.0 9741.0 9890.7 680.5 689.2 702.8 732.1 754.0 4511.9 4582.9 4587.2 4617.0 4621.6 73585.3 75610.6 75621.2 75844.6 76259.0 66819.7 66920.3 68478.7 69871.3 70211.6 63296.7 63466.0 63536.0 63573.4 64060.0 8804.3 8819.0 8863.6 8905.2 9153.2 38618.0 39975.6 40245.8 40753.8 40999.6 45623.8 45920.0 51708.5 55044.7 55533.0 11727.9 12550.5 12610.6 12655.4 12744.8 13326.5 13461.7 13964.4 14316.9 14666.7 12623.6 12636.3 12845.9 13240.3 13268.7 11982.1 12010.2 12015.5 12019.8 12384.4 12208.7 12258.1 12530.6 12551.3 12657.9 10929.6 11398.1 11440.9 11444.4 11464.9 10355.6 10580.5 10834.9 10846.3 10884.8 01:22:58 INFO - PROCESS | 23481 | -------- Summary: end -------- 01:22:58 INFO - PROCESS | 23481 | 01:22:58 INFO - TEST-INFO | 23481: exit 0 01:22:58 INFO - TEST-OK | dromaeo_css | took 1112989ms 01:22:58 INFO - TEST-START | kraken 01:22:58 INFO - operating with platform_type : linux_ 01:22:58 INFO - Initialising browser for kraken test... 01:22:58 INFO - TEST-INFO | started process 23661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBtgiQc/profile http://localhost:44527/getInfo.html) 01:23:02 INFO - PROCESS | 23661 | __metrics Screen width/height:1600/1200 01:23:02 INFO - PROCESS | 23661 | colorDepth:24 01:23:02 INFO - PROCESS | 23661 | Browser inner width/height: 1024/697 01:23:02 INFO - PROCESS | 23661 | __metrics 01:23:03 ERROR - PROCESS | 23661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:23:04 INFO - TEST-INFO | 23661: exit 0 01:23:04 INFO - Browser initialized. 01:23:04 INFO - Running cycle 1/1 for kraken test... 01:23:04 INFO - TEST-INFO | started process 23741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBtgiQc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:23:16 INFO - PROCESS | 23741 | RSS: Main: 153096192 01:23:16 INFO - PROCESS | 23741 | 01:23:19 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44527/tests/kraken/driver.html?testName=audio-beat-detection) 01:23:19 INFO - PROCESS | 23741 | RSS: Main: 208539648 01:23:19 INFO - PROCESS | 23741 | 01:23:22 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44527/tests/kraken/driver.html?testName=audio-dft) 01:23:23 INFO - PROCESS | 23741 | RSS: Main: 198328320 01:23:23 INFO - PROCESS | 23741 | 01:23:26 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44527/tests/kraken/driver.html?testName=audio-fft) 01:23:27 INFO - PROCESS | 23741 | RSS: Main: 265719808 01:23:27 INFO - PROCESS | 23741 | 01:23:29 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44527/tests/kraken/driver.html?testName=audio-oscillator) 01:23:29 INFO - PROCESS | 23741 | RSS: Main: 174309376 01:23:29 INFO - PROCESS | 23741 | 01:23:32 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:23:32 INFO - PROCESS | 23741 | RSS: Main: 178659328 01:23:32 INFO - PROCESS | 23741 | 01:23:35 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44527/tests/kraken/driver.html?testName=imaging-darkroom) 01:23:36 INFO - PROCESS | 23741 | RSS: Main: 214249472 01:23:36 INFO - PROCESS | 23741 | 01:23:40 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44527/tests/kraken/driver.html?testName=imaging-desaturate) 01:23:40 INFO - PROCESS | 23741 | RSS: Main: 212234240 01:23:40 INFO - PROCESS | 23741 | 01:23:43 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44527/tests/kraken/driver.html?testName=json-parse-financial) 01:23:44 INFO - PROCESS | 23741 | RSS: Main: 213602304 01:23:44 INFO - PROCESS | 23741 | 01:23:45 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:23:46 INFO - PROCESS | 23741 | RSS: Main: 202493952 01:23:46 INFO - PROCESS | 23741 | 01:23:48 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:23:48 INFO - PROCESS | 23741 | RSS: Main: 208556032 01:23:48 INFO - PROCESS | 23741 | 01:23:50 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:23:51 INFO - PROCESS | 23741 | RSS: Main: 217972736 01:23:51 INFO - PROCESS | 23741 | 01:23:54 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:23:54 INFO - PROCESS | 23741 | RSS: Main: 223019008 01:23:54 INFO - PROCESS | 23741 | 01:23:57 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:23:58 INFO - PROCESS | 23741 | RSS: Main: 219828224 01:23:58 INFO - PROCESS | 23741 | 01:23:59 INFO - PROCESS | 23741 | Cycle 1(1): loaded http://localhost:44527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44527/tests/kraken/driver.html?testName=ai-astar) 01:24:00 INFO - PROCESS | 23741 | RSS: Main: 265875456 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | __start_tp_report 01:24:00 INFO - PROCESS | 23741 | _x_x_mozilla_page_load 01:24:00 INFO - PROCESS | 23741 | _x_x_mozilla_page_load_details 01:24:00 INFO - PROCESS | 23741 | |i|pagename|runs| 01:24:00 INFO - PROCESS | 23741 | |0;ai-astar;109;105;109;109;110;109;109;110;109;107 01:24:00 INFO - PROCESS | 23741 | |1;audio-beat-detection;152;126;151;225;132;152;151;132;191;130 01:24:00 INFO - PROCESS | 23741 | |2;audio-dft;161;161;159;160;160;159;162;161;160;160 01:24:00 INFO - PROCESS | 23741 | |3;audio-fft;78;75;76;156;75;75;75;74;137;74 01:24:00 INFO - PROCESS | 23741 | |4;audio-oscillator;93;92;147;92;92;92;128;91;92;123 01:24:00 INFO - PROCESS | 23741 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;117;116;116 01:24:00 INFO - PROCESS | 23741 | |6;imaging-darkroom;145;145;147;146;145;145;146;146;146;146 01:24:00 INFO - PROCESS | 23741 | |7;imaging-desaturate;94;95;95;96;95;94;95;95;96;95 01:24:00 INFO - PROCESS | 23741 | |8;json-parse-financial;56;54;54;54;53;54;59;106;52;51 01:24:00 INFO - PROCESS | 23741 | |9;json-stringify-tinderbox;60;60;60;60;60;59;59;59;60;60 01:24:00 INFO - PROCESS | 23741 | |10;stanford-crypto-aes;77;77;82;78;82;78;80;79;78;80 01:24:00 INFO - PROCESS | 23741 | |11;stanford-crypto-ccm;120;125;133;118;120;119;121;117;195;121 01:24:00 INFO - PROCESS | 23741 | |12;stanford-crypto-pbkdf2;161;160;160;160;164;160;161;165;163;160 01:24:00 INFO - PROCESS | 23741 | |13;stanford-crypto-sha256-iterative;64;62;64;63;63;65;63;62;62;62 01:24:00 INFO - PROCESS | 23741 | __end_tp_report 01:24:00 INFO - PROCESS | 23741 | __start_cc_report 01:24:00 INFO - PROCESS | 23741 | _x_x_mozilla_cycle_collect,1830 01:24:00 INFO - PROCESS | 23741 | __end_cc_report 01:24:00 INFO - PROCESS | 23741 | __startTimestamp1463387040230__endTimestamp 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | ------- Summary: start ------- 01:24:00 INFO - PROCESS | 23741 | Number of tests: 14 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.51 (1.4%) stddev-sans-first:1.59 01:24:00 INFO - PROCESS | 23741 | Values: 109.0 105.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 107.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:151.50 stddev:31.20 (20.6%) stddev-sans-first:33.09 01:24:00 INFO - PROCESS | 23741 | Values: 152.0 126.0 151.0 225.0 132.0 152.0 151.0 132.0 191.0 130.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 01:24:00 INFO - PROCESS | 23741 | Values: 161.0 161.0 159.0 160.0 160.0 159.0 162.0 161.0 160.0 160.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.00 stddev:30.39 (40.5%) stddev-sans-first:31.95 01:24:00 INFO - PROCESS | 23741 | Values: 78.0 75.0 76.0 156.0 75.0 75.0 75.0 74.0 137.0 74.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:92.00 stddev:20.54 (22.3%) stddev-sans-first:21.38 01:24:00 INFO - PROCESS | 23741 | Values: 93.0 92.0 147.0 92.0 92.0 92.0 128.0 91.0 92.0 123.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:24:00 INFO - PROCESS | 23741 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 01:24:00 INFO - PROCESS | 23741 | Values: 145.0 145.0 147.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 01:24:00 INFO - PROCESS | 23741 | Values: 94.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 96.0 95.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:54.00 stddev:16.55 (30.7%) stddev-sans-first:17.51 01:24:00 INFO - PROCESS | 23741 | Values: 56.0 54.0 54.0 54.0 53.0 54.0 59.0 106.0 52.0 51.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:24:00 INFO - PROCESS | 23741 | Values: 60.0 60.0 60.0 60.0 60.0 59.0 59.0 59.0 60.0 60.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:1.85 (2.3%) stddev-sans-first:1.80 01:24:00 INFO - PROCESS | 23741 | Values: 77.0 77.0 82.0 78.0 82.0 78.0 80.0 79.0 78.0 80.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:121.00 stddev:23.67 (19.6%) stddev-sans-first:24.89 01:24:00 INFO - PROCESS | 23741 | Values: 120.0 125.0 133.0 118.0 120.0 119.0 121.0 117.0 195.0 121.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 01:24:00 INFO - PROCESS | 23741 | Values: 161.0 160.0 160.0 160.0 164.0 160.0 161.0 165.0 163.0 160.0 01:24:00 INFO - PROCESS | 23741 | 01:24:00 INFO - PROCESS | 23741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:1.05 01:24:00 INFO - PROCESS | 23741 | Values: 64.0 62.0 64.0 63.0 63.0 65.0 63.0 62.0 62.0 62.0 01:24:00 INFO - PROCESS | 23741 | -------- Summary: end -------- 01:24:00 INFO - PROCESS | 23741 | 01:24:01 INFO - TEST-INFO | 23741: exit 0 01:24:01 INFO - TEST-OK | kraken | took 62314ms 01:24:01 INFO - SUITE-END | took 1175s 01:24:01 INFO - Completed test suite (00:19:35) 01:24:01 INFO - javascript benchmark 01:24:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.34262804811, 3159.778815482914, 3176.9205769855753, 3193.345364200339, 3210.293735378216, 5223.347081614798, 5265.9473405265935, 5355.357357117146, 5432.8913421731595, 5469.425710300421, 5326.201069839526, 5347.358317001956, 5349.732513374335, 5363.919541206885, 5372.194170874371, 4798.640101992356, 4818.87952801181, 4934.185859333205, 4950.3069570260195, 4986.401631804189, 4925.138100832358, 4936.333594964688, 4988.850334489971, 4993.0, 5001.17480615698, 4767.737774422405, 4892.755362231892, 4941.950580494185, 4954.925676114861, 4960.181570040939, 4945.208766597327, 4959.280904268897, 4967.205247160437, 4973.7513124344, 5021.121303771825, 4722.315264286659, 4919.827806026808, 4934.679245849008, 4948.084604348207, 5018.2974383586325, 5186.170212765977, 5201.037808005493, 5225.634205605609, 5284.5243928046275, 5314.92027619586, 5659.0, 5715.657060576379, 5715.685637289947, 5723.9141412878425, 5735.082386818089, 5670.914936275959, 5728.5417166626985, 5729.5702822288495, 5732.770689172428, 5737.512311453532, 5388.084025715638, 5469.371022332443, 5485.314335708036, 5493.752781124819, 5498.065328894098, 5987.760489580455, 6004.399560044048, 6004.579679422399, 6005.069214271794, 6010.489108425745, 5517.0, 5583.469570390806, 5596.132599447093, 5744.281964754406, 5744.310682718101, 5760.135979603093, 5766.4233576642, 5766.88466230673, 5777.306723193244, 5802.709864506758, 5699.344575373802, 5707.686077265707, 5729.598928075078, 5746.741396637078, 5747.597668163272, 5471.288732464834, 5684.317881854121, 5688.77244910199, 5697.116946873241, 5722.113072473773, 4400.405945197422, 4401.911961760747, 4402.163588918095, 4404.889877753082, 4435.35687325336, 3890.902727431837, 3909.4722212500947, 3920.157166209279, 3959.0696186396176, 3973.8013099344917, 5347.679139251657, 5395.379531353866, 5461.836144915659, 5474.671519708751, 5509.559235261169, 5809.8547536311935, 5839.328477225088, 5854.8536286592325, 5860.882782344329, 5861.120831875252, 5539.584531160179, 5547.41752116022, 5547.417521160301, 5550.861228469321, 5554.944450555524, 4884.194107972145, 4924.581410580069, 4940.481249468754, 4944.60443164546, 4952.876178095505, 5947.702614869239, 5966.105084237399, 5971.940280597139, 5972.910406343908, 5973.910391344133, 5772.5959182856795, 5777.3933736957015, 5782.479576838105, 5783.94216057834, 5786.189933409242, 5732.111522713986, 5836.445537674084, 5844.883102338014, 5948.643081415129, 5955.910661339996, 5605.719714014202, 5623.381428042994, 5655.321361436654, 5660.85847853807, 5728.8567785804025, 5801.274840644919, 5818.4763371296785, 5819.5344372450945, 5823.4176582343125, 5825.679587622722, 5398.946010539844, 5641.605087643826, 5644.040513112698, 5661.348944871393, 5664.830055098354, 5573.944260557342, 5598.300212473441, 5624.128260119688, 5690.231818704588, 5699.629524080921, 5522.723863806874, 5561.193626923992, 5571.526420254162, 5601.887962240814, 5616.466435688603, 5519.641223320471, 5589.469000444951, 5702.45826646468, 5707.942920570741, 5744.13837924298, 5500.58745594074, 5537.944620553743, 5539.307586551681, 5546.251256080377, 5593.664380137205], "value": 5313.595586646648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0, 628.3402427451176, 645.2837350540901, 655.8229278094915, 659.9241087274964, 42602.36096458552, 43851.12297754043, 43874.12251754967, 43942.780286098525, 47089.29366059512, 45255.77372113143, 45656.3151552727, 45974.77012614932, 46012.769936150275, 46016.539834601725, 8911.376203665763, 8979.730608081769, 9012.324075694349, 9060.682876099338, 9063.546822658873, 8906.064863189336, 8990.190882820545, 8993.505357205351, 9000.369974101815, 9001.369904106716, 9083.364164508486, 9113.95443022784, 9121.224695900857, 9122.407043542182, 9126.498042607654, 9021.233195178418, 9050.909490905138, 9059.547022648907, 9064.18422341989, 9066.863997040049, 8901.42140760855, 8966.910330896673, 8971.955140224323, 8974.237189838872, 8977.865332020025, 42854.78572607148, 43167.78416107899, 43211.78394108041, 43369.78315108436, 43443.565564344266, 3544.3442963051916, 3678.8160591970563, 3738.9813050934845, 4000.7599544027453, 4419.779011049467, 33054.33891322184, 33183.0, 33646.1588460288, 33652.0, 33725.15687107817, 3805.9429108563395, 3830.9616903830884, 3886.3587508061137, 3917.4319723640197, 3923.156521347924, 371704.0, 373806.0, 374139.0, 375595.0, 376710.0, 53283.0, 54288.0, 58848.70575647095, 61443.38556614376, 61829.690851545456, 60953.390466094774, 65278.0, 65414.34585654082, 65665.34334656688, 65700.34299657038, 16372.263248153862, 16595.50213493597, 16629.50111496657, 16644.58388540296, 16654.75017874733, 11220.719482012852, 11772.529098836121, 11782.469788859522, 12466.626001219978, 12713.173643713313, 19374.321898733477, 19500.082108751525, 19512.219511219675, 19517.034407808784, 19554.413367598994, 7299.5620262784405, 7369.668364923591, 7403.444741644398, 7442.776716698508, 7547.50941188821, 983.7098056073476, 1053.878803937557, 1054.3726482742757, 1140.406988366045, 1150.764093360859, 32186.19534511609, 32577.674223257465, 32757.508637370458, 32819.22148777657, 32903.3419331612, 1138.9316641001567, 1147.6614398752388, 1163.1973937982934, 1192.070185255502, 1197.6047904191596, 16534.6693066138, 17155.485335439957, 17162.656746864992, 17215.65568688619, 17311.826881731275, 601040.0, 601286.0, 604876.0, 605507.0, 605579.0, 57024.42975570191, 57499.42500575024, 57803.421965780646, 57873.710631447415, 57882.42117578854, 1397.1617029782049, 1414.0384538513704, 1414.2716501001992, 1423.4946593958996, 1442.1995792335144, 30916.0, 31150.221244468165, 31729.0, 31816.204594885312, 32280.838595806872, 50421.74789126031, 50738.49261507337, 50865.237021443965, 50890.0, 50908.74545627248, 446851.0, 454719.0, 456507.0, 457105.0, 485110.0, 27508.44983100367, 28064.737086830733, 28148.577771333035, 28204.71795282103, 29346.413071738018, 44961.32558011698, 48717.26924096212, 48962.26556601725, 49559.256611151584, 50016.0, 40401.595984039785, 41162.65970120929, 41274.0, 41874.37188442237, 42393.788031059645, 40591.39112913368, 40777.79611102044, 40858.0, 41160.38259426051, 41338.58661413468, 40967.0, 41543.0, 42056.158876822905, 42183.0, 44473.33290000588, 34493.65506344904, 36616.26767464689, 37512.624873750916, 37757.0, 37828.24343513059, 28388.5968660257, 28632.284192894513, 28917.890864377652, 29007.7099229005, 29040.0], "value": 20541.761412866956, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.3523098273746, 414.1323926374245, 414.7552943763179, 414.890054135654, 424.9107687385649, 13582.388792504336, 18056.0, 19486.902565487188, 19658.0, 19677.803221967795, 14692.632684182901, 17392.47822565322, 17542.64914701705, 18164.727529087075, 18372.35696750614, 5789.884202315951, 5902.085176797603, 5927.110933360009, 5933.376995415484, 5980.671063091529, 5855.443732845394, 5904.084866845646, 5933.910991335133, 5944.762209511614, 5955.255593050869, 4221.936670949938, 6078.118672792442, 6363.0, 6373.330800265975, 6567.113439685629, 6444.162258906359, 6528.6409247491365, 6536.673166341688, 6561.2782593914635, 6571.539992200548, 5594.384617692051, 5699.173619825144, 5718.142278658193, 5730.7707691692285, 5741.712914354265, 22499.887500562556, 22776.20283290077, 22788.430289242737, 23192.30423087293, 23854.403639908967, 2358.4457652451833, 2444.083468699238, 2467.6668649732237, 2469.790067844235, 2638.5514462541223, 13783.173009619455, 14312.713745725132, 14389.424423023067, 14626.780598291034, 15256.084634921941, 1976.8418526517844, 1994.7706013808452, 2017.515796208914, 2034.5527449136268, 2106.273335699181, 84334.0, 84551.5772421134, 85547.0, 86247.56876215641, 87135.0, 10757.946210269056, 10916.67249982486, 11076.612318568812, 11107.944460277648, 11188.216824822184, 15445.227738613024, 15585.064896106043, 15597.68804623901, 15600.29798659063, 15612.76580851288, 8074.515529068275, 8426.873596896052, 8434.62044208012, 8534.487930724177, 8549.401541892008, 7991.8401631967035, 8083.19168083187, 8083.393745469113, 8185.3042491387705, 8213.219744124299, 6062.302835173923, 6471.5146364022885, 6704.363085506967, 6732.124823772878, 6860.245373008965, 1825.195220622816, 1916.0, 1973.8716983396034, 1981.127834196699, 2006.959860802805, 996.5963784667222, 1039.8440233964966, 1075.8327214971687, 1093.3112139352156, 1094.2887123369715, 19331.226750930087, 19692.803071969385, 19906.104225309897, 20013.199472020955, 20116.29592964239, 1027.3784360461962, 1048.9790204196026, 1062.3254233561745, 1082.4154956323655, 1085.403028334413, 9598.520073996273, 11623.0, 11643.243189192845, 11658.88341116578, 11670.183087183816, 456795.0, 464847.0, 469343.0, 469398.0, 473425.0, 55272.72363638156, 82679.0, 84258.0, 85111.5744421274, 85703.57148214344, 1043.3791893823163, 1060.2366296266675, 1071.196602548089, 1076.036946932491, 1081.432248069754, 17309.701772367374, 17607.20767565437, 17839.732404013692, 17871.28514859391, 18135.27458901682, 38296.2340753189, 38510.22979540337, 39427.0, 40257.59742402656, 40971.59028409797, 51423.74288128685, 52952.73523632357, 53415.46584534105, 53468.73265633647, 53791.0, 8755.605997730245, 8936.910630893868, 9046.140616641409, 9111.954440227757, 9207.079292070739, 13306.534271300845, 13858.930705346409, 13863.376148073563, 14024.158550487004, 14084.295785210903, 11827.763444731228, 11940.402979851146, 12070.637880863587, 12073.879261207276, 12544.121911466109, 10404.791904162026, 11804.881951180721, 11813.586524471602, 11900.35842651265, 12124.333161676192, 12077.51689932393, 12081.57714479989, 12099.455524501594, 12321.876781232073, 12347.814782778445, 8610.913890861011, 8747.562146696764, 8894.688685895962, 9093.818123637358, 9114.0, 12016.218945768496, 12079.637610871689, 12303.44634491432, 12306.630801075982, 12374.566890158801], "value": 9534.696507525041, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.48059535888, 1402.5371627362972, 1491.090434834751, 1521.4142555116277, 1665.209025712786, 8697.478151310917, 9029.367944243897, 9053.592588333524, 9300.767480812983, 9302.069793020695, 8890.066543012988, 9114.270858331334, 9125.771855703611, 9127.771805704844, 9148.954255228731, 2320.025589252514, 2344.4724936889234, 2344.554534638422, 2345.2260753951155, 2345.683332750074, 2409.8433601815827, 2442.1940759549307, 2444.584420648494, 2448.571499987504, 2451.0318424222423, 2374.192774456684, 2384.7138343398815, 2395.9520809583887, 2400.6759087523137, 2413.963790543143, 2251.1333136742473, 2264.467850055236, 2266.5580211858696, 2273.954520909581, 2284.9200277990276, 2256.1539422716482, 2258.1757658454544, 2258.706368172127, 2263.4793997380693, 2264.3320220534815, 8898.777530561723, 8999.730008099768, 9079.500627465486, 9092.499737543298, 9123.361364704473, 5365.839024829262, 5520.447955204488, 5524.972375138099, 5525.502704756551, 5528.668279903179, 3440.9483857742152, 3506.736994725406, 3536.664016918389, 3558.466230065485, 3567.4827150063097, 1091.1925175370247, 1112.6606385052555, 1127.6335191062938, 1146.9254498457574, 1149.2702134144795, 13035.283059431727, 13152.079354445194, 13153.86846131536, 13160.210387376788, 13161.341932903413, 4553.33976573395, 4626.1726617985705, 4661.953380466152, 4707.95292047082, 4722.504137065627, 10230.539625716712, 10298.948505257425, 10300.896991029993, 10307.123894468905, 10330.586776528855, 5374.785008599691, 5378.408375078739, 5381.3811411687375, 5382.1119515280325, 5387.6228663993925, 4358.084802191512, 4742.715437073718, 4920.901581968412, 4931.0, 4957.925631115536, 3874.8256328465286, 3902.687784977195, 3936.075022369741, 3978.4430179774854, 3982.104026594051, 1207.8007128823822, 1212.1454374665839, 1224.8285240066398, 1236.8577613574555, 1246.9064820138526, 735.3455424671939, 944.3153713557753, 987.9308448408686, 989.9406035637885, 1002.5789168549227, 5829.59192856496, 5984.670843103584, 6091.725872335755, 6097.756089756449, 6152.692365381713, 981.1513041219293, 1020.4030642074321, 1049.8267785815256, 1102.7904698107495, 1102.795982743195, 4099.057216840143, 4199.559046300155, 4200.831966721297, 4208.684348673862, 4224.471941007374, 11373.886261137448, 11544.826827597593, 11584.652460426201, 11587.188896777145, 11617.302961822317, 10978.780424391627, 11663.475143618558, 11734.765304693858, 11782.234154779911, 11814.409279535988, 8289.212524810133, 8649.178328058699, 8681.524140896063, 8746.781330466662, 8750.51872147038, 6124.8775024500155, 6223.751049957951, 6312.495000400048, 6371.745130194926, 6510.283868774336, 10663.306885052447, 10757.946210269212, 10771.19216058783, 10873.293235939638, 10897.782044359226, 10795.406252655865, 11034.889651103385, 11106.111511079256, 11185.384803835866, 11198.44007799623, 7324.926750732425, 7786.532808031537, 7886.211378862068, 7968.203179681986, 8030.277275045274, 8913.0, 8929.06244844282, 8963.910360896569, 8974.37179397462, 9010.729678109667, 7894.289513943772, 8084.029916410069, 8121.959390203011, 8181.877271840808, 8192.016957964845, 7749.651265692944, 7905.802354941173, 7921.722739704082, 7961.6019199040975, 8065.274125328749, 6987.336203060701, 7003.1596208453275, 7048.013278140962, 7072.68172932209, 7076.575405475688, 5272.156454967187, 5274.762635681327, 5354.3574771027725, 5381.542568881689, 5396.892062158657, 5165.044466773659, 5243.108671525773, 5332.906754115319, 5369.1140961740875, 5401.756920938488], "value": 4762.0038895855605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.2166725693735, 339.5500961226374, 340.24465686176677, 342.29828850855745, 349.0958417698161, 5349.358077030757, 5352.170413585891, 5375.75809088591, 5412.566994640424, 5417.972910135449, 5066.417362003371, 5118.3640425180965, 5210.713410762407, 5246.501582349681, 5345.224942383362, 4117.114820313632, 4154.750714957097, 4165.708400411972, 4168.416421700949, 4188.937165942506, 4189.245935731567, 4193.370994350857, 4202.222588821078, 4205.663546916239, 4209.684273679471, 3980.7412518186225, 4002.979240293721, 4162.854300099497, 4172.415861779354, 4188.246115699173, 4137.855175068858, 4145.0, 4155.33514637658, 4163.958360416387, 4165.354370072643, 3718.1819999600043, 3721.3673675475234, 3732.085639018431, 3743.5320584926885, 3753.9436908446396, 5058.241263810458, 5082.390113186404, 5092.592592592584, 5114.769835357418, 5211.557017653504, 4713.316569097496, 4727.574518293336, 4731.124741922756, 4734.597559207472, 4743.976280118612, 5483.341998960111, 5485.6982865942755, 5508.338999320107, 5531.889362212773, 5546.69493177875, 3982.283189025974, 4048.1498885234137, 4050.2709512287774, 4057.8173982170874, 4090.1001779608437, 5651.8304450866535, 5659.7453114609525, 5683.953776640406, 5690.146478028288, 5706.343770466367, 4119.855805046809, 4142.150859073882, 4151.6886233532605, 4152.522459917088, 4176.519700234451, 4046.959530404717, 4196.664266858644, 4219.430376899079, 4223.627321120648, 4249.597632781175, 4732.337472753818, 4765.642576806753, 4771.904561908743, 4782.206672497813, 4786.377770889762, 5541.362743284493, 5567.995521612216, 5607.504660426152, 5615.578831587647, 5618.247058941171, 1403.4947418929178, 1408.7252985667697, 1434.6771976305247, 1452.4771082410323, 1455.3087283540444, 877.3376101043799, 891.3225948279354, 893.1559676106148, 1010.141379827141, 1027.8098551767798, 5303.390110137384, 5343.7060961647485, 5360.839174824761, 5361.142217245222, 5385.219143224211, 5557.221988921554, 5663.555793272689, 5675.517581005661, 5679.432056794288, 5688.48803607669, 5358.571314294925, 5372.7313634318125, 5385.299911011543, 5386.703731294817, 5393.2179833923865, 2953.8227706337257, 2967.703229677058, 2972.212363723615, 2977.211039074604, 2984.268854130752, 5547.2511210986, 5800.854978625483, 5816.47651711348, 5819.912701309484, 5847.210626565445, 5725.625849796019, 5727.140928860621, 5734.885302293931, 5736.799212027559, 5748.815450128925, 5774.653520788598, 5787.276590426281, 5814.796482123105, 5829.8251052468495, 5832.591718579743, 5431.293931788842, 5755.539556835527, 5758.568107391879, 5769.567282453749, 5774.191613174243, 5670.603057785916, 5674.900286893876, 5692.800751973661, 5704.771809127588, 5739.30690446311, 5722.456366645162, 5925.585209035326, 5931.495822854933, 5946.375630558729, 5979.5814292999075, 4159.625633692982, 4163.916721665611, 4172.561881002573, 4191.97904010478, 4201.45381100455, 5679.602427830012, 5704.716438801236, 5755.683437410982, 5756.683382414008, 5782.363939966516, 5415.756290966837, 5552.7778888843995, 5552.972235138798, 5560.582956278215, 5620.85947851307, 5495.835124946258, 5506.760978779743, 5537.972310138423, 5559.805406810742, 5571.582131340247, 5272.736363181903, 5302.761375738024, 5435.565154787687, 5442.319710036246, 5525.171224316385, 5563.388027317073, 5581.7209139543675, 5590.630295577609, 5608.943910561005, 5619.100943849128, 5199.92200116991, 5417.322834645669, 5500.28496295479, 5516.393196748274, 5516.779328826802], "value": 4253.996083036095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.736934703507, 788.1921030943282, 835.9582020898954, 873.9737807865766, 887.915648013439, 14430.134191948464, 14894.776578351333, 15080.622984425394, 15245.466408675698, 15256.69486610267, 13162.07865449419, 13314.201147931131, 13331.866681333184, 13332.200067995902, 13350.132241404302, 702.220535205921, 816.1389733830806, 828.3000864269698, 840.8822764812932, 841.1714461255658, 836.9330453563731, 837.794740288627, 839.1147339556766, 839.559231403512, 840.6175190288404, 868.2186032570673, 868.431177578687, 869.1699427047155, 869.3827382558391, 869.678219058946, 713.9607321597337, 847.7414388611502, 859.4113032572676, 862.9093945135796, 864.3171894203572, 641.4002907281659, 642.0369445831253, 642.1202951955851, 642.2197030607834, 642.4314481683743, 14424.206668633222, 14448.277586120757, 14477.493287734984, 14481.493147739779, 14503.41986320546, 13658.453661853513, 13865.861341386559, 14095.436182552685, 14133.363998620087, 14290.857091429056, 11761.823572646417, 11979.221350612183, 12037.578684746079, 12228.938855305667, 12245.632631021084, 4425.491068527129, 4443.178012067778, 4507.414036175309, 4623.029163875556, 4624.260118381077, 57403.71298143482, 57499.71250143764, 57506.0, 57774.71112644494, 57875.0, 10030.197584193247, 10500.474976251156, 10713.89286107129, 11413.657590272305, 11463.484143213574, 18739.34412295563, 18921.81078189228, 19776.40670779879, 19797.60404791925, 19800.821909589933, 8484.32125429964, 8594.183552562497, 8598.484090954562, 8694.347923905732, 8729.781755456164, 4833.951660483421, 4885.096257192431, 4914.5822605078965, 4951.851444456672, 4964.081644895706, 3319.336132773455, 3440.724742020632, 3503.8598456061472, 3512.631173726722, 3526.083218363193, 582.3361368040437, 601.5458328961606, 652.8008957267983, 653.3792896748108, 659.5844617890698, 638.2596188421409, 724.5037149552574, 791.4538968111984, 803.4857691077715, 804.8913396691489, 9663.613455461844, 9671.419714817133, 9693.0, 9740.95129524362, 9890.65382711616, 680.4794332335767, 689.2452764223168, 702.8067281497629, 732.0885497555578, 753.9924600754032, 4511.8646440606835, 4582.908341833211, 4587.1513769952, 4616.976915115403, 4621.630269578425, 73585.26414735892, 75610.6219468899, 75621.24378756252, 75844.62077689686, 76259.0, 66819.66590167017, 66920.33079669239, 68478.65760671165, 69871.3012869875, 70211.64894175496, 63296.683516582125, 63466.0, 63536.0, 63573.36426635767, 64060.0, 8804.339674524308, 8819.0, 8863.601137948679, 8905.243054340453, 9153.221976132103, 38618.0, 39975.60024399835, 40245.79877100596, 40753.796231018656, 40999.59000410077, 45623.77188114038, 45920.0, 51708.48291517187, 55044.724776377465, 55533.0, 11727.882721172678, 12550.49798008106, 12610.558630447891, 12655.430505627084, 12744.753253057434, 13326.466941322238, 13461.730765384833, 13964.371603277674, 14316.928415357857, 14666.706665866835, 12623.621291360907, 12636.30500322491, 12845.871541284841, 13240.337983100613, 13268.734625307246, 11982.10134239918, 12010.219335743148, 12015.519379224734, 12019.75960480803, 12384.380780960735, 12208.694782630506, 12258.14193006481, 12530.624081277576, 12551.3096779678, 12657.93671031639, 10929.56281748753, 11398.145139114433, 11440.885591143982, 11444.370559619301, 11464.885351146715, 10355.585776568852, 10580.532691488661, 10834.945825270823, 10846.29499082557, 10884.782304354027], "value": 7066.260481139461, "unit": "score"}], "name": "dromaeo_css", "value": 7281.024080537563, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 107.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 151.0, 225.0, 132.0, 152.0, 151.0, 132.0, 191.0, 130.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 160.0, 159.0, 162.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 156.0, 75.0, 75.0, 75.0, 74.0, 137.0, 74.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 147.0, 92.0, 92.0, 92.0, 128.0, 91.0, 92.0, 123.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 53.0, 54.0, 59.0, 106.0, 52.0, 51.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 82.0, 78.0, 82.0, 78.0, 80.0, 79.0, 78.0, 80.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 125.0, 133.0, 118.0, 120.0, 119.0, 121.0, 117.0, 195.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 164.0, 160.0, 161.0, 165.0, 163.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 63.0, 63.0, 65.0, 63.0, 62.0, 62.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 01:24:01 INFO - Return code: 0 01:24:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:24:01 ERROR - # TBPL SUCCESS # 01:24:01 INFO - Running post-action listener: _resource_record_post_action 01:24:01 INFO - ##### 01:24:01 INFO - ##### Finished run-tests step (success) 01:24:01 INFO - ##### 01:24:01 INFO - Running post-run listener: _resource_record_post_run 01:24:01 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537124864; Read time: 16; Write time: 376900 01:24:01 INFO - TinderboxPrint: CPU usage
13.0% 01:24:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:24:01 INFO - TinderboxPrint: I/O write bytes / time
537,124,864 / 376,900 01:24:01 INFO - TinderboxPrint: CPU idle
8,278.4 (86.9%) 01:24:01 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 01:24:01 INFO - TinderboxPrint: Swap in / out
0 / 0 01:24:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246419456; Read time: 0; Write time: 191848 01:24:01 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290705408; Read time: 16; Write time: 185052 01:24:02 INFO - Running post-run listener: _upload_blobber_files 01:24:02 INFO - Blob upload gear active. 01:24:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:24:02 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 01:24:02 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:24:02 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:24:02 INFO - (blobuploader) - INFO - Open directory for files ... 01:24:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:24:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:24:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:03 INFO - (blobuploader) - INFO - Done attempting. 01:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:07 INFO - (blobuploader) - INFO - Done attempting. 01:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:24:07 INFO - (blobuploader) - INFO - Done attempting. 01:24:07 INFO - (blobuploader) - INFO - Iteration through files over. 01:24:07 INFO - Return code: 0 01:24:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:24:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:24:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e6f923cb46077b9a0b0c4e6ae5cbb3526a3a5663c65d28b59ebb884d544b7aa19c4d3d6f1f8df66b573b8be369d2810346df222aeb38574f8f881316e76dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7d0474fc34c77ff492a45364372957ea73d894bb9ac490b88c747c6ef2ed5bf73ef19e810eb39e4394aa6e59013f4e829e4f983eaa3fd065c7de339a00db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7aca9dbd5113dad839e81b1e12ab383d3734b6fbc4a82b82ae1a74d9a4687feab73274c3c407a263a1e5c8dc7cbd9d0d88e466163503dedb98d80d27c5af4ef"} 01:24:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:24:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:24:07 INFO - Contents: 01:24:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e6f923cb46077b9a0b0c4e6ae5cbb3526a3a5663c65d28b59ebb884d544b7aa19c4d3d6f1f8df66b573b8be369d2810346df222aeb38574f8f881316e76dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7d0474fc34c77ff492a45364372957ea73d894bb9ac490b88c747c6ef2ed5bf73ef19e810eb39e4394aa6e59013f4e829e4f983eaa3fd065c7de339a00db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7aca9dbd5113dad839e81b1e12ab383d3734b6fbc4a82b82ae1a74d9a4687feab73274c3c407a263a1e5c8dc7cbd9d0d88e466163503dedb98d80d27c5af4ef"} 01:24:07 INFO - Running post-run listener: copy_logs_to_upload_dir 01:24:07 INFO - Copying logs to upload dir... 01:24:07 INFO - mkdir: /builds/slave/test/build/upload/logs 01:24:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.772098 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 01:24:07.655094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 01:24:07.659899) ========= 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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26e6f923cb46077b9a0b0c4e6ae5cbb3526a3a5663c65d28b59ebb884d544b7aa19c4d3d6f1f8df66b573b8be369d2810346df222aeb38574f8f881316e76dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7d0474fc34c77ff492a45364372957ea73d894bb9ac490b88c747c6ef2ed5bf73ef19e810eb39e4394aa6e59013f4e829e4f983eaa3fd065c7de339a00db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7aca9dbd5113dad839e81b1e12ab383d3734b6fbc4a82b82ae1a74d9a4687feab73274c3c407a263a1e5c8dc7cbd9d0d88e466163503dedb98d80d27c5af4ef"} build_url:https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/IzJnqMlMRXCWg-DM8esqgA/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/Firefox/sha512/26e6f923cb46077b9a0b0c4e6ae5cbb3526a3a5663c65d28b59ebb884d544b7aa19c4d3d6f1f8df66b573b8be369d2810346df222aeb38574f8f881316e76dec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d7d0474fc34c77ff492a45364372957ea73d894bb9ac490b88c747c6ef2ed5bf73ef19e810eb39e4394aa6e59013f4e829e4f983eaa3fd065c7de339a00db6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7aca9dbd5113dad839e81b1e12ab383d3734b6fbc4a82b82ae1a74d9a4687feab73274c3c407a263a1e5c8dc7cbd9d0d88e466163503dedb98d80d27c5af4ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 01:24:07.687945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:24:07.688296) ========= 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=00204705a9daa57ed339a427000001b9-1463385260.563806-2033995026 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 01:24:07.770664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 01:24:07.771014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 01:24:07.771335) ========= ========= Total master_lag: 0.24 =========