builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1463837057.69 results: success (0) buildid: 20160521050632 builduid: dd40ba2ea4044ef58791702d21c49b39 revision: 16663eb3dcfa759f25b5e27b101bc79270c156f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.695917) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.696377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.696923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.736855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.737355) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 06:24:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-21 06:24:17 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.857402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.857750) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020103 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.919209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:17.919585) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 16663eb3dcfa759f25b5e27b101bc79270c156f2 --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 16663eb3dcfa759f25b5e27b101bc79270c156f2 --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=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 06:24:17,957 truncating revision to first 12 chars 2016-05-21 06:24:17,958 Setting DEBUG logging. 2016-05-21 06:24:17,958 attempt 1/10 2016-05-21 06:24:17,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/16663eb3dcfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 06:24:18,289 unpacking tar archive at: mozilla-central-16663eb3dcfa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:18.544040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:18.544703) ========= script_repo_revision: 16663eb3dcfa759f25b5e27b101bc79270c156f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:18.545636) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:18.546244) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 06:24:18.557652) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-21 06:24:18.557968) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:18 INFO - MultiFileLogger online at 20160521 06:24:18 in /builds/slave/test 06:24:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:24:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:18 INFO - {'append_to_log': False, 06:24:18 INFO - 'base_work_dir': '/builds/slave/test', 06:24:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:24:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:18 INFO - 'branch': 'Firefox-Non-PGO', 06:24:18 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:18 INFO - 'config_files': ('talos/linux_config.py',), 06:24:18 INFO - 'default_actions': ('clobber', 06:24:18 INFO - 'read-buildbot-config', 06:24:18 INFO - 'download-and-extract', 06:24:18 INFO - 'populate-webroot', 06:24:18 INFO - 'create-virtualenv', 06:24:18 INFO - 'install', 06:24:18 INFO - 'run-tests'), 06:24:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:18 INFO - 'download_minidump_stackwalk': True, 06:24:18 INFO - 'download_symbols': 'ondemand', 06:24:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:18 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:18 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:18 INFO - 'installer_path': 'installer.exe', 06:24:18 INFO - 'log_level': 'info', 06:24:18 INFO - 'log_name': 'talos', 06:24:18 INFO - 'log_to_console': True, 06:24:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:18 INFO - 'opt_config_files': (), 06:24:18 INFO - 'pip_index': False, 06:24:18 INFO - 'sps_profile': False, 06:24:18 INFO - 'sps_profile_interval': 0, 06:24:18 INFO - 'suite': 'dromaeojs', 06:24:18 INFO - 'system_bits': '32', 06:24:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:18 INFO - 'title': 'talos-linux64-ix-061', 06:24:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:18 INFO - 'use_talos_json': True, 06:24:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:18 INFO - 'work_dir': 'build'} 06:24:18 INFO - ##### 06:24:18 INFO - ##### Running clobber step. 06:24:18 INFO - ##### 06:24:18 INFO - Running pre-action listener: _resource_record_pre_action 06:24:18 INFO - Running main action method: clobber 06:24:18 INFO - rmtree: /builds/slave/test/build 06:24:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:19 INFO - Running post-action listener: _resource_record_post_action 06:24:19 INFO - ##### 06:24:19 INFO - ##### Finished clobber step (success) 06:24:19 INFO - ##### 06:24:19 INFO - ##### 06:24:19 INFO - ##### Running read-buildbot-config step. 06:24:19 INFO - ##### 06:24:19 INFO - Running pre-action listener: _resource_record_pre_action 06:24:19 INFO - Running main action method: read_buildbot_config 06:24:19 INFO - Using buildbot properties: 06:24:19 INFO - { 06:24:19 INFO - "project": "", 06:24:19 INFO - "product": "firefox", 06:24:19 INFO - "script_repo_revision": "production", 06:24:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:24:19 INFO - "repository": "", 06:24:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:24:19 INFO - "buildid": "20160521050632", 06:24:19 INFO - "pgo_build": "False", 06:24:19 INFO - "basedir": "/builds/slave/test", 06:24:19 INFO - "buildnumber": 94, 06:24:19 INFO - "slavename": "talos-linux64-ix-061", 06:24:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:24:19 INFO - "platform": "ubuntu64_hw", 06:24:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:24:19 INFO - "branch": "mozilla-central", 06:24:19 INFO - "repo_path": "mozilla-central", 06:24:19 INFO - "revision": "16663eb3dcfa759f25b5e27b101bc79270c156f2", 06:24:19 INFO - "stage_platform": "linux64", 06:24:19 INFO - "builduid": "dd40ba2ea4044ef58791702d21c49b39", 06:24:19 INFO - "slavebuilddir": "test" 06:24:19 INFO - } 06:24:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:24:19 INFO - Running post-action listener: _resource_record_post_action 06:24:19 INFO - ##### 06:24:19 INFO - ##### Finished read-buildbot-config step (success) 06:24:19 INFO - ##### 06:24:19 INFO - ##### 06:24:19 INFO - ##### Running download-and-extract step. 06:24:19 INFO - ##### 06:24:19 INFO - Running pre-action listener: _resource_record_pre_action 06:24:19 INFO - Running main action method: download_and_extract 06:24:19 INFO - mkdir: /builds/slave/test/build/tests 06:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:19 INFO - https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:24:26 INFO - Downloaded 1361 bytes. 06:24:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:24:26 INFO - Using the following test package requirements: 06:24:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:24:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:24:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'jsshell-linux-x86_64.zip'], 06:24:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:24:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:24:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:24:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:24:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:24:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:24:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:24:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:24: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')]} 06:24:26 INFO - https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:28 INFO - Downloaded 22814329 bytes. 06:24:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:24:29 INFO - Return code: 0 06:24:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:29 INFO - https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:24:36 INFO - Downloaded 22814329 bytes. 06:24: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'] 06:24: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 06:24:37 INFO - Return code: 0 06:24: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')]} 06:24:37 INFO - https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:24:38 INFO - Downloaded 10840359 bytes. 06:24:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:24:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:24:38 INFO - Return code: 0 06:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:38 INFO - https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:24:40 INFO - Downloaded 54824219 bytes. 06:24:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:24:40 INFO - mkdir: /builds/slave/test/properties 06:24:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:24:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:24:40 INFO - Contents: 06:24:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:24:40 INFO - Running post-action listener: _resource_record_post_action 06:24:40 INFO - Running post-action listener: set_extra_try_arguments 06:24:40 INFO - ##### 06:24:40 INFO - ##### Finished download-and-extract step (success) 06:24:40 INFO - ##### 06:24:40 INFO - ##### 06:24:40 INFO - ##### Running populate-webroot step. 06:24:40 INFO - ##### 06:24:40 INFO - Running pre-action listener: _resource_record_pre_action 06:24:40 INFO - Running main action method: populate_webroot 06:24:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:24:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:24:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:24:40 INFO - '--tppagecycles', 06:24:40 INFO - '7'], 06:24:40 INFO - 'tests': ['tsvgm']}}, 06:24:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:24:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:24:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:24:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:24:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:24:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['damp', 'tps']}, 06:24:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'tests': ['damp', 'tps']}, 06:24:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['dromaeo_dom']}, 06:24:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:24:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'other-e10s': {'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['a11yr', 06:24:40 INFO - 'ts_paint', 06:24:40 INFO - 'tpaint', 06:24:40 INFO - 'sessionrestore', 06:24:40 INFO - 'sessionrestore_no_auto_restore', 06:24:40 INFO - 'tabpaint']}, 06:24:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['tsvgx', 06:24:40 INFO - 'tsvgr_opacity', 06:24:40 INFO - 'tart', 06:24:40 INFO - 'tscrollx', 06:24:40 INFO - 'cart']}, 06:24:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:24:40 INFO - 'tsvgr_opacity', 06:24:40 INFO - 'tart', 06:24:40 INFO - 'tscrollx', 06:24:40 INFO - 'cart']}, 06:24:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'talos_options': ['--disable-e10s'], 06:24:40 INFO - 'tests': ['tp5o']}, 06:24:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'tests': ['tp5o']}, 06:24:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'talos_options': ['--disable-e10s', 06:24:40 INFO - '--xperf_path', 06:24:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:40 INFO - 'tests': ['tp5n']}, 06:24:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:24:40 INFO - 'talos_options': ['--xperf_path', 06:24:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:24:40 INFO - 'tests': ['tp5n']}}, 06:24:40 INFO - 'talos.zip': {'path': '', 06:24:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:24:40 INFO - Running post-action listener: _resource_record_post_action 06:24:40 INFO - ##### 06:24:40 INFO - ##### Finished populate-webroot step (success) 06:24:40 INFO - ##### 06:24:40 INFO - ##### 06:24:40 INFO - ##### Running create-virtualenv step. 06:24:40 INFO - ##### 06:24:40 INFO - Running pre-action listener: _resource_record_pre_action 06:24:40 INFO - Running main action method: create_virtualenv 06:24:40 INFO - Creating virtualenv /builds/slave/test/build/venv 06:24:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:24:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:24:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:24:40 INFO - Using real prefix '/usr' 06:24:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:24:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:24:43 INFO - Installing pip.................done. 06:24:43 INFO - Return code: 0 06:24:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:43 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:24:43 INFO - Using env: {'DISPLAY': ':0', 06:24:43 INFO - 'HOME': '/home/cltbld', 06:24:43 INFO - 'LANG': 'en_US.UTF-8', 06:24:43 INFO - 'LANGUAGE': 'en_US:en', 06:24:43 INFO - 'LOGNAME': 'cltbld', 06:24:43 INFO - 'MAIL': '/var/mail/cltbld', 06:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:43 INFO - 'MOZ_NO_REMOTE': '1', 06:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:43 INFO - 'NO_EM_RESTART': '1', 06:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:43 INFO - 'PWD': '/builds/slave/test', 06:24:43 INFO - 'SHELL': '/bin/bash', 06:24:43 INFO - 'SHLVL': '1', 06:24:43 INFO - 'TERM': 'linux', 06:24:43 INFO - 'TMOUT': '86400', 06:24:43 INFO - 'USER': 'cltbld', 06:24:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:43 INFO - '_': '/tools/buildbot/bin/python'} 06:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:24:43 INFO - Cleaning up... 06:24:43 INFO - Return code: 0 06:24:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:43 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:24:43 INFO - Using env: {'DISPLAY': ':0', 06:24:43 INFO - 'HOME': '/home/cltbld', 06:24:43 INFO - 'LANG': 'en_US.UTF-8', 06:24:43 INFO - 'LANGUAGE': 'en_US:en', 06:24:43 INFO - 'LOGNAME': 'cltbld', 06:24:43 INFO - 'MAIL': '/var/mail/cltbld', 06:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:43 INFO - 'MOZ_NO_REMOTE': '1', 06:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:43 INFO - 'NO_EM_RESTART': '1', 06:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:43 INFO - 'PWD': '/builds/slave/test', 06:24:43 INFO - 'SHELL': '/bin/bash', 06:24:43 INFO - 'SHLVL': '1', 06:24:43 INFO - 'TERM': 'linux', 06:24:43 INFO - 'TMOUT': '86400', 06:24:43 INFO - 'USER': 'cltbld', 06:24:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:43 INFO - '_': '/tools/buildbot/bin/python'} 06:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:43 INFO - Downloading/unpacking psutil>=3.1.1 06:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:24:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:45 INFO - Installing collected packages: psutil 06:24:45 INFO - Running setup.py install for psutil 06:24:46 INFO - building 'psutil._psutil_linux' extension 06:24:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:24:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:24:46 INFO - building 'psutil._psutil_posix' extension 06:24:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:24:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:24:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:24:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:24:46 INFO - Successfully installed psutil 06:24:46 INFO - Cleaning up... 06:24:46 INFO - Return code: 0 06:24:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:24: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 mozsystemmonitor==0.3 06:24:46 INFO - Using env: {'DISPLAY': ':0', 06:24:46 INFO - 'HOME': '/home/cltbld', 06:24:46 INFO - 'LANG': 'en_US.UTF-8', 06:24:46 INFO - 'LANGUAGE': 'en_US:en', 06:24:46 INFO - 'LOGNAME': 'cltbld', 06:24:46 INFO - 'MAIL': '/var/mail/cltbld', 06:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:46 INFO - 'MOZ_NO_REMOTE': '1', 06:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:46 INFO - 'NO_EM_RESTART': '1', 06:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:46 INFO - 'PWD': '/builds/slave/test', 06:24:46 INFO - 'SHELL': '/bin/bash', 06:24:46 INFO - 'SHLVL': '1', 06:24:46 INFO - 'TERM': 'linux', 06:24:46 INFO - 'TMOUT': '86400', 06:24:46 INFO - 'USER': 'cltbld', 06:24:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:46 INFO - '_': '/tools/buildbot/bin/python'} 06:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:24:48 INFO - Installing collected packages: mozsystemmonitor 06:24:48 INFO - Running setup.py install for mozsystemmonitor 06:24:48 INFO - Successfully installed mozsystemmonitor 06:24:48 INFO - Cleaning up... 06:24:49 INFO - Return code: 0 06:24:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:49 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:24:49 INFO - Using env: {'DISPLAY': ':0', 06:24:49 INFO - 'HOME': '/home/cltbld', 06:24:49 INFO - 'LANG': 'en_US.UTF-8', 06:24:49 INFO - 'LANGUAGE': 'en_US:en', 06:24:49 INFO - 'LOGNAME': 'cltbld', 06:24:49 INFO - 'MAIL': '/var/mail/cltbld', 06:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:49 INFO - 'MOZ_NO_REMOTE': '1', 06:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:49 INFO - 'NO_EM_RESTART': '1', 06:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:49 INFO - 'PWD': '/builds/slave/test', 06:24:49 INFO - 'SHELL': '/bin/bash', 06:24:49 INFO - 'SHLVL': '1', 06:24:49 INFO - 'TERM': 'linux', 06:24:49 INFO - 'TMOUT': '86400', 06:24:49 INFO - 'USER': 'cltbld', 06:24:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:49 INFO - '_': '/tools/buildbot/bin/python'} 06:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:49 INFO - Downloading/unpacking blobuploader==1.2.4 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:24:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:52 INFO - Downloading docopt-0.6.1.tar.gz 06:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:24:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:24:52 INFO - Running setup.py install for blobuploader 06:24:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:24:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:24:52 INFO - Running setup.py install for requests 06:24:52 INFO - Running setup.py install for docopt 06:24:52 INFO - Successfully installed blobuploader requests docopt 06:24:52 INFO - Cleaning up... 06:24:52 INFO - Return code: 0 06:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:52 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:24:52 INFO - Using env: {'DISPLAY': ':0', 06:24:52 INFO - 'HOME': '/home/cltbld', 06:24:52 INFO - 'LANG': 'en_US.UTF-8', 06:24:52 INFO - 'LANGUAGE': 'en_US:en', 06:24:52 INFO - 'LOGNAME': 'cltbld', 06:24:52 INFO - 'MAIL': '/var/mail/cltbld', 06:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:52 INFO - 'MOZ_NO_REMOTE': '1', 06:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:52 INFO - 'NO_EM_RESTART': '1', 06:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:52 INFO - 'PWD': '/builds/slave/test', 06:24:52 INFO - 'SHELL': '/bin/bash', 06:24:52 INFO - 'SHLVL': '1', 06:24:52 INFO - 'TERM': 'linux', 06:24:52 INFO - 'TMOUT': '86400', 06:24:52 INFO - 'USER': 'cltbld', 06:24:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:52 INFO - '_': '/tools/buildbot/bin/python'} 06:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:52 INFO - Running setup.py (path:/tmp/pip-Er5dC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:53 INFO - Running setup.py (path:/tmp/pip-x26mK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:53 INFO - Running setup.py (path:/tmp/pip-tgjyeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:53 INFO - Running setup.py (path:/tmp/pip-W3A1Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:53 INFO - Running setup.py (path:/tmp/pip-iVS6KF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:53 INFO - Running setup.py (path:/tmp/pip-wcnKlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:53 INFO - Running setup.py (path:/tmp/pip-oi2HA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:53 INFO - Running setup.py (path:/tmp/pip-dCLizo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:53 INFO - Running setup.py (path:/tmp/pip-0OkJzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:53 INFO - Running setup.py (path:/tmp/pip-BhRb9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:53 INFO - Running setup.py (path:/tmp/pip-GRtPcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:53 INFO - Running setup.py (path:/tmp/pip-aTs9u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:53 INFO - Running setup.py (path:/tmp/pip-O4dC9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:53 INFO - Running setup.py (path:/tmp/pip-fY26CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:53 INFO - Running setup.py (path:/tmp/pip-MOQ4gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:54 INFO - Running setup.py (path:/tmp/pip-hMVpnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:54 INFO - Running setup.py (path:/tmp/pip-SkwPNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:24:54 INFO - Running setup.py install for manifestparser 06:24:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Running setup.py install for mozcrash 06:24:54 INFO - Running setup.py install for mozdebug 06:24:54 INFO - Running setup.py install for mozdevice 06:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Running setup.py install for mozfile 06:24:54 INFO - Running setup.py install for mozhttpd 06:24:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Running setup.py install for mozinfo 06:24:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Running setup.py install for mozInstall 06:24:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:54 INFO - Running setup.py install for mozleak 06:24:55 INFO - Running setup.py install for mozlog 06:24:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for moznetwork 06:24:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for mozprocess 06:24:55 INFO - Running setup.py install for mozprofile 06:24:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for mozrunner 06:24:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Running setup.py install for mozscreenshot 06:24:55 INFO - Running setup.py install for moztest 06:24:55 INFO - Running setup.py install for mozversion 06:24:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:55 INFO - Cleaning up... 06:24:55 INFO - Return code: 0 06:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:55 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:24:55 INFO - Using env: {'DISPLAY': ':0', 06:24:55 INFO - 'HOME': '/home/cltbld', 06:24:55 INFO - 'LANG': 'en_US.UTF-8', 06:24:55 INFO - 'LANGUAGE': 'en_US:en', 06:24:55 INFO - 'LOGNAME': 'cltbld', 06:24:55 INFO - 'MAIL': '/var/mail/cltbld', 06:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:55 INFO - 'MOZ_NO_REMOTE': '1', 06:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:55 INFO - 'NO_EM_RESTART': '1', 06:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:55 INFO - 'PWD': '/builds/slave/test', 06:24:55 INFO - 'SHELL': '/bin/bash', 06:24:55 INFO - 'SHLVL': '1', 06:24:55 INFO - 'TERM': 'linux', 06:24:55 INFO - 'TMOUT': '86400', 06:24:55 INFO - 'USER': 'cltbld', 06:24:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:55 INFO - '_': '/tools/buildbot/bin/python'} 06:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:56 INFO - Running setup.py (path:/tmp/pip-8U6bGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:56 INFO - Running setup.py (path:/tmp/pip-9bA_Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:56 INFO - Running setup.py (path:/tmp/pip-6Ua1Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:56 INFO - Running setup.py (path:/tmp/pip-DSclkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:56 INFO - Running setup.py (path:/tmp/pip-QHBd4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:56 INFO - Running setup.py (path:/tmp/pip-6wsWEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:56 INFO - Running setup.py (path:/tmp/pip-XisVUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:56 INFO - Running setup.py (path:/tmp/pip-7rJQ6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:56 INFO - Running setup.py (path:/tmp/pip-UIj9yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:56 INFO - Running setup.py (path:/tmp/pip-7oFXpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:56 INFO - Running setup.py (path:/tmp/pip-Mna9Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:56 INFO - Running setup.py (path:/tmp/pip-EtDnGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:57 INFO - Running setup.py (path:/tmp/pip-diwPra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:57 INFO - Running setup.py (path:/tmp/pip-Uhcc7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:57 INFO - Running setup.py (path:/tmp/pip-BW2Ych-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:57 INFO - Running setup.py (path:/tmp/pip-foGxPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:57 INFO - Running setup.py (path:/tmp/pip-9Ft4h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:24:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:59 INFO - Downloading blessings-1.6.tar.gz 06:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:59 INFO - Installing collected packages: blessings 06:24:59 INFO - Running setup.py install for blessings 06:24:59 INFO - Successfully installed blessings 06:24:59 INFO - Cleaning up... 06:24:59 INFO - Return code: 0 06:24:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:59 INFO - Reading from file tmpfile_stdout 06:24:59 INFO - Current package versions: 06:24:59 INFO - argparse == 1.2.1 06:24:59 INFO - blessings == 1.6 06:24:59 INFO - blobuploader == 1.2.4 06:24:59 INFO - docopt == 0.6.1 06:24:59 INFO - manifestparser == 1.1 06:24:59 INFO - mozInstall == 1.12 06:24:59 INFO - mozcrash == 0.17 06:24:59 INFO - mozdebug == 0.1 06:24:59 INFO - mozdevice == 0.48 06:24:59 INFO - mozfile == 1.2 06:24:59 INFO - mozhttpd == 0.7 06:24:59 INFO - mozinfo == 0.9 06:24:59 INFO - mozleak == 0.1 06:24:59 INFO - mozlog == 3.2 06:24:59 INFO - moznetwork == 0.27 06:24:59 INFO - mozprocess == 0.22 06:24:59 INFO - mozprofile == 0.28 06:24:59 INFO - mozrunner == 6.11 06:24:59 INFO - mozscreenshot == 0.1 06:24:59 INFO - mozsystemmonitor == 0.3 06:24:59 INFO - moztest == 0.7 06:24:59 INFO - mozversion == 1.4 06:24:59 INFO - psutil == 3.1.1 06:24:59 INFO - requests == 1.2.3 06:24:59 INFO - wsgiref == 0.1.2 06:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:59 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:24:59 INFO - Using env: {'DISPLAY': ':0', 06:24:59 INFO - 'HOME': '/home/cltbld', 06:24:59 INFO - 'LANG': 'en_US.UTF-8', 06:24:59 INFO - 'LANGUAGE': 'en_US:en', 06:24:59 INFO - 'LOGNAME': 'cltbld', 06:24:59 INFO - 'MAIL': '/var/mail/cltbld', 06:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:59 INFO - 'MOZ_NO_REMOTE': '1', 06:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:59 INFO - 'NO_EM_RESTART': '1', 06:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:59 INFO - 'PWD': '/builds/slave/test', 06:24:59 INFO - 'SHELL': '/bin/bash', 06:24:59 INFO - 'SHLVL': '1', 06:24:59 INFO - 'TERM': 'linux', 06:24:59 INFO - 'TMOUT': '86400', 06:24:59 INFO - 'USER': 'cltbld', 06:24:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:59 INFO - '_': '/tools/buildbot/bin/python'} 06:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:24:59 INFO - Cleaning up... 06:24:59 INFO - Return code: 0 06:24:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24:59 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 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:24:59 INFO - Using env: {'DISPLAY': ':0', 06:24:59 INFO - 'HOME': '/home/cltbld', 06:24:59 INFO - 'LANG': 'en_US.UTF-8', 06:24:59 INFO - 'LANGUAGE': 'en_US:en', 06:24:59 INFO - 'LOGNAME': 'cltbld', 06:24:59 INFO - 'MAIL': '/var/mail/cltbld', 06:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:59 INFO - 'MOZ_NO_REMOTE': '1', 06:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:59 INFO - 'NO_EM_RESTART': '1', 06:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:59 INFO - 'PWD': '/builds/slave/test', 06:24:59 INFO - 'SHELL': '/bin/bash', 06:24:59 INFO - 'SHLVL': '1', 06:24:59 INFO - 'TERM': 'linux', 06:24:59 INFO - 'TMOUT': '86400', 06:24:59 INFO - 'USER': 'cltbld', 06:24:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:59 INFO - '_': '/tools/buildbot/bin/python'} 06:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:00 INFO - Downloading/unpacking jsonschema 06:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:25:02 INFO - Downloading/unpacking functools32 (from jsonschema) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:25:02 INFO - warning: no files found matching '*.txt' 06:25:02 INFO - no previously-included directories found matching 'build' 06:25:02 INFO - no previously-included directories found matching 'dist' 06:25:02 INFO - no previously-included directories found matching '.git*' 06:25:02 INFO - Installing collected packages: jsonschema, functools32 06:25:02 INFO - Running setup.py install for functools32 06:25:02 INFO - warning: no files found matching '*.txt' 06:25:02 INFO - no previously-included directories found matching 'build' 06:25:02 INFO - no previously-included directories found matching 'dist' 06:25:02 INFO - no previously-included directories found matching '.git*' 06:25:02 INFO - Successfully installed jsonschema functools32 06:25:02 INFO - Cleaning up... 06:25:02 INFO - Return code: 0 06:25:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:25: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')]} 06:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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')]} 06:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2ffa41f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14928e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:25: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', 'flake8'] in /builds/slave/test/build 06:25: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 flake8 06:25:02 INFO - Using env: {'DISPLAY': ':0', 06:25:02 INFO - 'HOME': '/home/cltbld', 06:25:02 INFO - 'LANG': 'en_US.UTF-8', 06:25:02 INFO - 'LANGUAGE': 'en_US:en', 06:25:02 INFO - 'LOGNAME': 'cltbld', 06:25:02 INFO - 'MAIL': '/var/mail/cltbld', 06:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:02 INFO - 'MOZ_NO_REMOTE': '1', 06:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:02 INFO - 'NO_EM_RESTART': '1', 06:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:02 INFO - 'PWD': '/builds/slave/test', 06:25:02 INFO - 'SHELL': '/bin/bash', 06:25:02 INFO - 'SHLVL': '1', 06:25:02 INFO - 'TERM': 'linux', 06:25:02 INFO - 'TMOUT': '86400', 06:25:02 INFO - 'USER': 'cltbld', 06:25:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:02 INFO - '_': '/tools/buildbot/bin/python'} 06:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:25:02 INFO - Downloading/unpacking flake8 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:25:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:25:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25: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 06:25:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:25:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:05 INFO - no previously-included directories found matching 'docs/_build' 06:25:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:25:05 INFO - Running setup.py install for pep8 06:25:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:25:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:25:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:25:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:25:05 INFO - no previously-included directories found matching 'docs/_build' 06:25:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:25:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:25:05 INFO - Cleaning up... 06:25:05 INFO - Return code: 0 06:25:05 INFO - Running post-action listener: _resource_record_post_action 06:25:05 INFO - Running post-action listener: _start_resource_monitoring 06:25:05 INFO - Starting resource monitoring. 06:25:05 INFO - ##### 06:25:05 INFO - ##### Finished create-virtualenv step (success) 06:25:05 INFO - ##### 06:25:05 INFO - ##### 06:25:05 INFO - ##### Running install step. 06:25:05 INFO - ##### 06:25:05 INFO - Running pre-action listener: _resource_record_pre_action 06:25:05 INFO - Running main action method: install 06:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:25:05 INFO - Reading from file tmpfile_stdout 06:25:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:25:05 INFO - Reading from file tmpfile_stdout 06:25:05 INFO - Output received: 06:25:05 INFO - Usage: mozinstall [options] installer 06:25:05 INFO - Options: 06:25:05 INFO - -h, --help show this help message and exit 06:25:05 INFO - -d DEST, --destination=DEST 06:25:05 INFO - Directory to install application into. [default: 06:25:05 INFO - "/builds/slave/test"] 06:25:05 INFO - --app=APP Application being installed. [default: firefox] 06:25:05 INFO - mkdir: /builds/slave/test/build/application 06:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:25:21 INFO - Reading from file tmpfile_stdout 06:25:21 INFO - Output received: 06:25:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:25:21 INFO - Running post-action listener: _resource_record_post_action 06:25:21 INFO - ##### 06:25:21 INFO - ##### Finished install step (success) 06:25:21 INFO - ##### 06:25:21 INFO - ##### 06:25:21 INFO - ##### Running run-tests step. 06:25:21 INFO - ##### 06:25:21 INFO - Running pre-action listener: _resource_record_pre_action 06:25:21 INFO - Running main action method: run_tests 06:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:25:21 INFO - Python 2.7.3 06:25:21 INFO - Return code: 0 06:25:21 INFO - grabbing minidump binary from tooltool 06:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:25:21 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 0x1521b20>, '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 0x1522a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1522eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:25:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:25:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:25:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:25:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:25:21 INFO - Return code: 0 06:25:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:25:22 INFO - Return code: 0 06:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:25:22 INFO - Using env: {'DISPLAY': ':0', 06:25:22 INFO - 'HOME': '/home/cltbld', 06:25:22 INFO - 'LANG': 'en_US.UTF-8', 06:25:22 INFO - 'LANGUAGE': 'en_US:en', 06:25:22 INFO - 'LOGNAME': 'cltbld', 06:25:22 INFO - 'MAIL': '/var/mail/cltbld', 06:25:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:25:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:25:22 INFO - 'MOZ_NO_REMOTE': '1', 06:25:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:25:22 INFO - 'NO_EM_RESTART': '1', 06:25:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:25:22 INFO - 'PWD': '/builds/slave/test', 06:25:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:25:22 INFO - 'SHELL': '/bin/bash', 06:25:22 INFO - 'SHLVL': '1', 06:25:22 INFO - 'TERM': 'linux', 06:25:22 INFO - 'TMOUT': '86400', 06:25:22 INFO - 'USER': 'cltbld', 06:25:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797', 06:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:25:22 INFO - '_': '/tools/buildbot/bin/python'} 06:25:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:25:22 INFO - mozversion application_buildid: 20160521050632 06:25:22 INFO - mozversion application_changeset: 16663eb3dcfa759f25b5e27b101bc79270c156f2 06:25:22 INFO - mozversion application_display_name: Nightly 06:25:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:25:22 INFO - mozversion application_name: Firefox 06:25:22 INFO - mozversion application_remotingname: firefox 06:25:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:25:22 INFO - mozversion application_vendor: Mozilla 06:25:22 INFO - mozversion application_version: 49.0a1 06:25:22 INFO - mozversion platform_buildid: 20160521050632 06:25:22 INFO - mozversion platform_changeset: 16663eb3dcfa759f25b5e27b101bc79270c156f2 06:25:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:25:22 INFO - mozversion platform_version: 49.0a1 06:25:22 INFO - using testdate: 1463837122 06:25:22 INFO - actual date: 1463837122 06:25:22 INFO - starting webserver on 'localhost:34789' 06:25:22 INFO - SUITE-START | Running 2 tests 06:25:22 INFO - TEST-START | dromaeo_css 06:25:22 INFO - operating with platform_type : linux_ 06:25:22 INFO - Initialising browser for dromaeo_css test... 06:25:22 INFO - TEST-INFO | started process 7161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9rEkw/profile http://localhost:34789/getInfo.html) 06:25:27 INFO - PROCESS | 7161 | __metrics Screen width/height:1600/1200 06:25:27 INFO - PROCESS | 7161 | colorDepth:24 06:25:27 INFO - PROCESS | 7161 | Browser inner width/height: 1024/697 06:25:27 INFO - PROCESS | 7161 | __metrics 06:25:28 ERROR - PROCESS | 7161 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:25:29 INFO - TEST-INFO | 7161: exit 0 06:25:29 INFO - Browser initialized. 06:25:29 INFO - Running cycle 1/1 for dromaeo_css test... 06:25:29 INFO - TEST-INFO | started process 7241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9rEkw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:25:41 INFO - PROCESS | 7241 | RSS: Main: 154894336 06:25:41 INFO - PROCESS | 7241 | 06:26:32 INFO - PROCESS | 7241 | 1463837192452 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:28:45 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34789/tests/dromaeo/cssquery-ext.html) 06:28:46 INFO - PROCESS | 7241 | RSS: Main: 251637760 06:28:46 INFO - PROCESS | 7241 | 06:31:48 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-ext.html (next: http://localhost:34789/tests/dromaeo/cssquery-jquery.html) 06:31:49 INFO - PROCESS | 7241 | RSS: Main: 232767488 06:31:49 INFO - PROCESS | 7241 | 06:34:51 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34789/tests/dromaeo/cssquery-mootools.html) 06:34:52 INFO - PROCESS | 7241 | RSS: Main: 234364928 06:34:52 INFO - PROCESS | 7241 | 06:37:54 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34789/tests/dromaeo/cssquery-prototype.html) 06:37:54 INFO - PROCESS | 7241 | RSS: Main: 231817216 06:37:54 INFO - PROCESS | 7241 | 06:40:57 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34789/tests/dromaeo/cssquery-yui.html) 06:40:58 INFO - PROCESS | 7241 | RSS: Main: 214695936 06:40:58 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | Cycle 1(1): loaded http://localhost:34789/tests/dromaeo/cssquery-yui.html (next: http://localhost:34789/tests/dromaeo/cssquery-dojo.html) 06:44:01 INFO - PROCESS | 7241 | RSS: Main: 277536768 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | __start_tp_report 06:44:01 INFO - PROCESS | 7241 | _x_x_mozilla_page_load 06:44:01 INFO - PROCESS | 7241 | _x_x_mozilla_page_load_details 06:44:01 INFO - PROCESS | 7241 | |i|pagename|runs| 06:44:01 INFO - PROCESS | 7241 | |0;dojo.html;2659.4282229320697;2665.453582015687;2690.2467309153444;2708.959365609515;2718.7824974002083;4588.2888152336445;4646.4191976003;4655.324977878206;4719.3392924990485;4757.881052973673;4662.11419830232;4706.270528068147;4717.103750287443;4723.504032076634;4727.1727447696685;4274.551172126937;4317.481902171744;4353.172897149548;4385.583369579885;4447.822087116511;4386.100849325897;4410.25025745624;4413.051193993291;4451.221036318648;4460.353248778925;4225.9788701056605;4270.295401258789;4282.186384586949;4296.2266791977745;4348.521662617125;4299.269124248885;4300.290452075404;4310.331898555697;4328.7835608219775;4358.564143585648;4335.458067741532;4343.782810859444;4348.695591308609;4384.868453946355;4397.296432570805;4531.705439146445;4544.2047641662575;4558.179527685015;4649.279361698942;4690.929636055462;5018.322526458918;5040.873978150539;5072;5089.389273287192;5091.389033315989;5087.821926232601;5104.821331253388;5114.130597798383;5118.2578526113875;5120.103981803207;4599.425071866017;4697.6241900647865;4708.9058218835435;4762.190427627312;4766.022965292107;5262.552683021986;5271.604629652715;5283.735813209324;5285.920711189336;5290.047791397586;5037.874053148627;5043.142665746758;5051.393832740095;5063.8480845574695;5065.088284108896;4898;4975.5522003019905;5035;5098.872528186751;5106.004329155853;5061.392632884003;5078.923816142761;5085.949140508547;5100.770465328995;5141;5049.343585333883;5066.290719299301;5067.41724701664;5067.5185857343495;5116.411612664591;4220.767857767853;4221;4265.786710664454;4322.286822674224;4373.365861949999;3733.4026555750947;3747.8875633730486;3753.7184711146774;3765.1340191755503;3819.789911554891;4277.465316835395;4304.526502084768;4311.762853043113;4346.369776382407;4346.456692913386;4974.626902982291;4990.3762029746285;5035.597152227813;5071.923921141186;5112.846614601568;4245.0448649053715;4325.653947684178;4331.848385306499;4333.1766964276685;4334.306510958295;4525.977370113128;4544.409226800495;4549.067441174618;4576.6109880660515;4589.472210695746;4737.692050016738;4740.674246957882;4741.0754902794315;4744.715317080986;4803.447603525639;4930.8767280818265;4988.4263309719845;5043.167877300204;5058.54473097423;5081.110805609078;4746;4769.73766442849;4788.7366194859615;4792.137415265286;4843.951560484491;5009.373828271466;5012.498750124958;5015.473375295542;5018.99620075979;5069.03688299222;4909.803607855646;5069.569086627531;5072.873178170576;5102.744862756922;5138.229265610188;4998.4251811042195;5016.899662006666;5018.623603229699;5025.547700706954;5055.5702765263895;5014.824481143142;5022.698638081727;5023.6985780853265;5032.144535429059;5058.747062646927;4770.689905156154;4774.355462012584;4829.1790395633525;4866.294387313749;4988.45127036033;4992.375953005874;4996.675216110941;4997.350344455343;5020.899582008413;5036.420811606712;4861.149298872612;4885.389326334208;4895.510448955076;4896.804127834846;4943.060818444484 06:44:01 INFO - PROCESS | 7241 | |1;ext.html;562.4150883081595;598.7365559153975;599.4155698194261;600.3786081405746;613.7514306705784;27767.861160694192;30435.391292174143;30517.542236866466;30521.542176867366;41674.7916260419;39902.60097399025;40069.79965100178;40124;40435.59564404355;40544.797276013654;7644.655990480428;7853.685852565891;7856.646450909694;7862.135165131859;7863.292303692667;7434.665440055183;7648.502847314934;9947.403155810674;10198.745031374201;10201.285909986304;10234.385936843813;10293.691189264335;10306.330088544259;10321.071103600674;10329.63846265381;7461;10097.596096156145;10155.7461063474;10174.745631359237;10178.796424071552;9830.852537211947;10206.540705668189;10215.131713804336;10549.84175237372;10567.63013294531;39687.20625587501;40184.78059803737;40205;40263.39604905929;40294.19411611751;3078.3843231353594;3120.329129237225;3175.7618178636462;3209.935801283985;3220.6940340667834;30510.54234186489;30653.69346306553;31062.844685776654;31161.22096947572;31506;3503.281827225438;3549.791276239197;3570.8571657133684;3604.153024039375;3643.599204087575;248740.75629621916;249343;251184;251468;251708.99999999817;54242.45757542453;54324.45675543273;54757.178642320396;54779.72610137003;54875;33348;34186.48720269148;34253.828730856185;35964.28071438557;36268.637313626525;12228.694282643006;12327.137100402886;12420.565280215149;12459.501619935283;12650.367481625883;8081;8752.912470875337;8785.560721963877;8801.911980880237;8846.363422766808;18145.092745362945;18941;19044.143013564422;19101.713474297896;19108.522286942938;7031;7078;7095.3968912643;7155.7495487658725;7185.712571497082;842.4818736477023;904.7602385367883;930.4091901642506;973.1047436358567;1002.4336250018862;28269.71730282671;28447.857760711064;29245.415091698047;29371.706282937324;29391;1006.9144122749502;1009.333839665817;1051.164324362134;1057.2070946789909;1069.4438891776388;14721.92639036798;15049.699006020037;15239.923800380928;15381.384744610314;15687.058776473448;397545;397547;398186;398580;405713;50603.24095138576;50918.745406273476;51097.48902510927;51265.487345126814;51378.48621513812;1121.4616983847798;1188.7563049574817;1192.6720151958107;1217.3973882928008;1234.4321612058554;28945.131646050653;29490.705092948796;29780.70219297866;30243;30369.848150759106;41895.7905210472;41944.1611167781;42350;42403.363949541395;42474.36288455738;287011;288835;289615;289899;290411;25202.621960670236;25956.480870382864;26084.478310433304;26181.214563563124;26317.4736505265;42849;42978.35532466953;43525;44393.11213775642;44636.776816115715;36377.27245455023;36842.631573684994;37586;37663.2467350646;37665.4350184742;36343.818280908425;36758.816205918796;37001.62998370089;37190.25619487649;37876;35225.64774352223;35709;36044.45933311055;36457;36600.45099323459;31160.22099447532;32636.347273054882;32934.67065329412;33509.664903350655;33560.66439335673;24952.500949981262;25478.490430191665;25652.56885038087;25811.870940645178;26063.348416288987 06:44:01 INFO - PROCESS | 7241 | |2;jquery.html;364.3205421888179;367.77381910125274;372.22948496612014;378.38701303887706;384.31783584138134;15834.841651583482;16693.165341732896;17024.744628830576;17091.40180093697;17333.393331233427;15229.4669686561;16681.83318166821;17817.198226079858;17894.642107157848;17910.462686119437;5091.338126043609;5240.34495688039;5251.343582052244;5276.182191760283;5279.815206467774;3795.601461846508;3971.8212680429306;5197.506236907488;5843.386444423338;6142.785002524913;6195.721192546346;6211.658358790265;6224.595401298924;6230;6235.5011599072195;5955.374685658008;6180.598261113036;6181.412765787243;6197.16338294329;6202.596831205957;3464.4630082337276;5093.2105523643895;5397.217403476513;5406.162044883049;5406.189071639246;19959.401217963485;20523.89738051315;20548.691769623467;20860.37418877436;20894.791052089437;1887.5092475956212;1951.4633475794128;1998.7401637786995;2149.258505815491;2388.10446082719;6588.308227636077;7265.927340726631;13175.670608234776;13730.45078196871;13779;1612.3389410341822;1739.4868513788335;1745.729411941151;1747.8863873848159;1791.0596936608254;67390.32609673939;67844.98232526565;68300.31699682989;68522.31477685209;68882.31117688809;10230.23273254509;10257.33327333721;10291.897081029243;10334.741631459274;10481.956018576304;14172.362243699059;14260.429582816778;14262.786058209134;14267.714645707236;14322.212278324583;6545;6649.202095748541;6686.732530698815;6769.22153952292;6785.457163427012;6089.847753806191;6113.419225173601;6145.569810113249;6247.5939063960695;6364.07720880479;4345.935245864784;4444.577765112309;4512.458504979423;4532.252178390595;4583.656225783079;1734.2976094681674;1768.5755418699678;1782.4563508130145;1871.0644677661169;1878.483417060292;892.8883889513811;916.867054277126;970.1705042188968;971.8639390485338;1008.5058321422597;15572.532824015298;16246.268917898722;16606.83393166077;16736.079515626756;17231.22459489326;858.4290051296407;861.5735211070435;906.5648488725449;922.5940586142076;937.315759495572;9269.629214831331;9301.53492325381;9538.284628652878;9555.522223888778;9721.076497732704;402505;403225.9516107261;403279;405517;405613;72313;74172.25827741761;76153;76563;76598;920.9309301802392;928.5867788833904;938.6949241496541;949.9097585729345;956.1012648110753;14799.92600036993;14811.777823332874;15108.773368399263;15161.442200470821;15190.772138418153;25288.494230115663;25350.1127460538;32107;34427;34735.13162170966;44076.77961610172;46261.30608040949;47724.522754772006;47856.76071619619;48364.758176208896;7762.611869406394;7921.524708517277;8057.274845263954;8063.475874068166;8070.192980701883;6988.37104660583;11072.833907491555;11429.257098288585;11651.825222621837;11668.766624667629;9243.815123697623;9950.154236889655;10041.347312424961;10146.441945693057;10505.31715438494;9640.084192001748;9856.5564549594;9930.702078937644;10191.796164076528;10208.387496750218;9688.9031109688;10159;10331.84502232452;10476.266661333633;10558.366498010144;7487.887681684888;7669.769906902802;7806.960965195365;7921.801954951173;7966.0440747110715;8243;9391.718248452557;10492.895071049192;10642.574297028032;10702.571897124028 06:44:01 INFO - PROCESS | 7241 | |3;mootools.html;1285.338050903784;1402.1376853235263;1434.540946896993;1551.6353656890628;1748.8426041656248;6693.36413040761;7291.08861392326;7518.135414427343;7529.924700752991;7534.095908490982;6875.346842050009;7029.543079699816;7035.577865328084;7226.674799634016;7228.4217262618995;1839.475749411418;2089.0808044460464;2166.068590506082;2171.174953517661;2218.4786575154826;2190.561887622474;2197.3847322749657;2197.637389830684;2198.307533127068;2201.966970495444;2135.754388245356;2147.5382792699565;2193.758686544487;2194.462356722597;2195.3523710505438;1816.1917946513806;2077.781832907553;2118.798714122156;2125.447383680239;2125.80867721905;2082.562661841015;2101.233049936762;2102.3797979596056;2103.8527303088636;2104.116271166114;7606.885896711554;7655.578943158124;7667.808304792425;7669.156392796788;7676.347510461617;4264.360345948133;4384.89037774055;4385.188740083063;4389.1660584488845;4392.253316936129;2763.903263385772;2931.809432386888;2931.868065937038;2954.084233887502;2957.8077424967523;867.6139118092451;867.8654808504692;882.1266945723752;899.6716198587468;908.7273817854617;10403.427811470367;10671;10684.465776711211;10699.251052426333;10715.892841071567;4141.689373297015;4156.792160392029;4251.213525497793;4251.808668609858;4259.488861336659;9170.587323570455;9179.541022948959;9203;9204.309676774268;9213.493257870747;4348.695591308641;4395.055063161436;4402.559744025636;4451.109778044404;4453.064856380196;3500.68493835556;3897.7466464679705;3996.360582306817;4008.5590585035625;4068.7151899367354;3650.2881938021833;3694.1872787987136;3774.1319496515957;3775.2638235544355;3842.7886466244627;1167.311286341063;1179.1569028144745;1204.476052916984;1205.6503613952032;1228.2630421747058;821.4250024982537;828.6436832162228;829.7966998085508;849.3332733803934;850.2262940723912;4915.58217551505;5109.412417571953;5148.073346797538;5256.658317209446;5301.231321458367;903.3541018172039;908.6910450446748;932.0613124700742;958.2860768727203;971.0823272008026;3449.137715571107;3604.513390692223;3637.5816781069984;3664.688501477351;3667.5048868402423;9567.37812042215;9813.214942804558;9938.204943604494;9979.301448898652;9989.750256243507;9530.857037144448;9849.901500985041;9868.555914983843;9873.703788886345;9875.111239988435;7181.102362204724;7253.093363329584;7389.556626602421;7396.260373962561;7432.145303290083;4815.759212039454;4816.133096042746;4918.827841025547;4952.925706114339;5005.024020316004;8912.688055918012;8912.821743565222;8939.553022348986;9008.504532250527;9042.276617870422;8610;9147.71931929517;9150.084991500797;9154.725358239264;9161.31290153228;5700.743466544099;5910.054391297372;6004.39956004396;6055.878882422415;6127.590654149481;7468.813279668052;7510.061242344707;7585.658645360862;7592.506487078323;7595.506292091218;6612.404883560503;6697.397234248746;6757.3242675732035;6810.897836532356;6817.965910170417;6646;6703.698333574904;6723.798286051427;6794.524383293122;6850.006749021463;6231.75072997075;6266.68666566679;6278.968605157128;6304.211973503312;6313.558050936574;4288.742675439484;4451.710638808467;4464.330350447459;4519.186546421675;4520.5931466166885;4620;4635.1656701794;4638.953610463987;4641.396618439581;4716.740579268036 06:44:01 INFO - PROCESS | 7241 | |4;prototype.html;293.7473772555603;296.8842151560891;298.05367956737354;306.17333200359036;309.8791471326183;4680.227762419197;4848.424262114813;4851.708897466155;4896.114995726649;4900.093482705697;4594.218982772928;4743.596794272482;4800.159972004903;4802.23164293713;4830.758462076891;3827.272818164554;3828.1960788234364;3835.76985380878;3839.9424008639894;3869.1294458746697;3649.835757390924;3715.9071023224365;3812.237552489499;3847.0377809086986;3848.1149335652817;3792.146766977422;3792.639699228569;3793.951266316186;3803.50554427924;3807.4669546263544;3774.4904437900805;3778.792166430845;3782.224643947984;3782.451544526056;3796.620337966209;3376.0547046826928;3380.171857894807;3381.0364046246946;3385.712214461774;3419.4699821527456;4497.437820272466;4572.245579479382;4580.9541904580865;4581.954180458186;4601.401817763669;4360.585744354281;4364.803583838735;4367.497737760166;4370.562943705604;4386.6929314947965;4962.230854217602;4989.627852340599;5022.522860328263;5027.5977921766535;5072.873178170576;3592.7305452090936;3684.1710615111388;3687.483752274684;3688.7498625838216;3737.4206997915367;5174.922376164361;5202.245674377232;5215.322008138955;5219.739013049332;5228.241904923765;3769.6418840210135;3770.775242606875;3786.9431958520645;3798.2973149967343;3805.2009078093356;3722.2927643747603;3848.942265866014;3850.557185923599;3861.189150278473;3871.6515513603913;4311.1377724454605;4336.262835318003;4345.152695224464;4363.781810909505;4364.4980827204645;5027.296178535008;5037.874053148627;5043.596512279082;5048.3941926969;5063.291139240509;1273.554256010389;1299.9805002924963;1306.2619619914908;1347.764141275273;1349.1365526063328;849.9405041647026;867.4968518259394;870.7779516223322;872.055316643875;878.3544095090103;3959.7822119783687;3963.69198164605;3982.0841206522664;3985.7608543487486;4001;4515.9774201128785;4534.36518887356;4558.495696420174;4570.657200709894;4597.367934383313;3919;3935.842566297373;3971.5631280559114;3987.6211759883345;3990.980045099814;2333.3349995251274;2422.9394265143515;2438.1466486729855;2445.3275349279093;2448.424620214248;4319.827206911688;4361.520232774392;4380.255356589388;4383.865536141674;4397.648188144941;4693.084848454587;4694.765261736899;4697.906041879143;4722.220833562424;4742.71946574423;4172;4329.095198112883;4361.825526978885;4388.5830846069575;4399.49405818335;4542.477615074309;4571.428571428572;4573.81704731807;4584.977075114603;4629.351890735367;4509.143262780061;4527.818887244473;4590.9370207366055;4594.701344412602;4623.6763426561165;4157;4381.583749543788;4415.315626077963;4421;4426.911461770811;3499.492573576766;3506.4389697649276;3527.2945410918433;3530.752847300767;3533.5406397168204;4607.884802879955;4654.6741728078705;4675.812967481399;4681.531846815291;5024.547790698854;4856.295837103671;4965.577925876341;4970.9254361183885;4984.950150498594;5023.648344615842;4926.285688575208;4929.926051109308;4947.208446648519;4973.577245933991;4983.401991761012;4845.41854977405;4865.9756701216265;4903.166461701448;4909.288153217692;4922;5012.724300163526;5023.974880125576;5031.547160755549;5033.3456650636645;5072.51811077947;4918.1393256180745;4931.48219436954;4942.827001054946;4970.850874473772;4978.859090590936 06:44:01 INFO - PROCESS | 7241 | |5;yui.html;672.5863593889758;762.1235579084056;766.8082979255184;771.1093686791754;776.2819392062341;12531.248125112488;12532.624021279365;12658.556950506734;12689.238645681266;12689.302088385135;11698.064154867612;11890.821637675443;11913.166078374517;11918.10614203936;11953.462094205759;644.5552568727586;793.4961299574754;803.48576910777;810.0481933727846;811.1199348706631;815.963281652327;823.7858156879224;824.1593574553951;824.5794644731201;828.9378296627747;841.5245386356689;843.6836186430089;845.8519759042174;846.0017179727919;846.2003406780594;666.4435196610835;823.1192623892438;836.0510820219096;836.4145098431122;846.090452763282;616.214326733414;617.9536534759866;619.683961179797;619.981400557984;620.5532016947791;12726.23642581448;12770.106092573524;12783.360831958458;12790.936045319806;12801.807972880415;11813;12553;12560.434780434902;12619;12962.22226666403;11181.798737570924;11229.719257018558;11592.07263418933;11640.4761785719;11923.94038029813;4071.3689378146437;4151.750894946283;4153.252414565377;4162.542120366757;4293.205756934945;44712.10575788499;45220.32169517493;45387;45390.546094538964;45467;9908.108270255712;9987.534280727998;10196.184305255561;10304.896951030543;10486.370817750807;18050;18050.638987220445;18059.638807223782;18065.458036258933;18084.45746627603;6629.734810607618;6703;6713.4964877634375;6883.483738719616;6888.207856096613;3546.13119785649;3613.602503724588;3617.439296908983;3641.6904563111902;3756.1360886996144;2515.421453065805;2599.3891435512637;2604.921852344433;2606.2962999990277;2610.1256079213294;421.77435072236204;471.77354869662065;478.91140139074383;479.3792039309103;480.9495003024702;610.8961476548998;612.1582823617526;623.6102435977514;626.1765778001912;644.6841047886502;8216.380967558782;8496.957515212385;8632.827343453097;8777.034526202113;8780.165884240987;481.9229023133294;516.7803683434526;586.4575267877282;619.0806652121596;659.0542571410042;3461.653834616518;3697.1681371691157;3697.6856967157555;3737.663610275088;3754.249150169977;56981;58782.11826822601;59198.40801592015;59332.70333648391;59432.405675943555;51170.232446513335;52395.47604523982;53282.73358633182;54442;54765.178522322196;48299.03401931941;48325.75837120792;48376.5162348379;48539.75730121327;49245.50754492481;6982.825429364307;7125.394341480825;7171.282871712787;7242.89135662955;7247;30843.845780770953;31220;31754.682453175174;31856.362872741953;32143.196420089684;39085.609143908194;39509.40735888907;41281.380779287734;41688.79155604202;42010.78994605008;11015;11458.312501249951;11472.88527114718;11498.137639677225;11502.88497115018;12390.442430090487;12430.440630171483;12653;12700.36498175069;12729.363531823186;10827.350358978487;11259.324440533266;11285.548578056785;11534.307941523535;12043.75912481763;11663.941680291884;11704.590339338083;11762.82355764647;11870.287782733063;12025.579104731642;10958.780824383308;11002.22984391117;11090.334579925231;11250.83123753128;11356.545738170711;9456.952715236379;9530.137636449817;9827.950860245654;9946.30375873711;10184.847227291448;9671.323007389416;9927.801443971224;10001.5499302533;10030.699079027641;10078.496075196064 06:44:01 INFO - PROCESS | 7241 | __end_tp_report 06:44:01 INFO - PROCESS | 7241 | __start_cc_report 06:44:01 INFO - PROCESS | 7241 | _x_x_mozilla_cycle_collect,913 06:44:01 INFO - PROCESS | 7241 | __end_cc_report 06:44:01 INFO - PROCESS | 7241 | __startTimestamp1463838241487__endTimestamp 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | ------- Summary: start ------- 06:44:01 INFO - PROCESS | 7241 | Number of tests: 6 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#0] dojo.html Cycles:165 Average:4682.71 Median:4774.36 stddev:496.46 (10.4%) stddev-sans-first:471.93 06:44:01 INFO - PROCESS | 7241 | Values: 2659.4 2665.5 2690.2 2709.0 2718.8 4588.3 4646.4 4655.3 4719.3 4757.9 4662.1 4706.3 4717.1 4723.5 4727.2 4274.6 4317.5 4353.2 4385.6 4447.8 4386.1 4410.3 4413.1 4451.2 4460.4 4226.0 4270.3 4282.2 4296.2 4348.5 4299.3 4300.3 4310.3 4328.8 4358.6 4335.5 4343.8 4348.7 4384.9 4397.3 4531.7 4544.2 4558.2 4649.3 4690.9 5018.3 5040.9 5072.0 5089.4 5091.4 5087.8 5104.8 5114.1 5118.3 5120.1 4599.4 4697.6 4708.9 4762.2 4766.0 5262.6 5271.6 5283.7 5285.9 5290.0 5037.9 5043.1 5051.4 5063.8 5065.1 4898.0 4975.6 5035.0 5098.9 5106.0 5061.4 5078.9 5085.9 5100.8 5141.0 5049.3 5066.3 5067.4 5067.5 5116.4 4220.8 4221.0 4265.8 4322.3 4373.4 3733.4 3747.9 3753.7 3765.1 3819.8 4277.5 4304.5 4311.8 4346.4 4346.5 4974.6 4990.4 5035.6 5071.9 5112.8 4245.0 4325.7 4331.8 4333.2 4334.3 4526.0 4544.4 4549.1 4576.6 4589.5 4737.7 4740.7 4741.1 4744.7 4803.4 4930.9 4988.4 5043.2 5058.5 5081.1 4746.0 4769.7 4788.7 4792.1 4844.0 5009.4 5012.5 5015.5 5019.0 5069.0 4909.8 5069.6 5072.9 5102.7 5138.2 4998.4 5016.9 5018.6 5025.5 5055.6 5014.8 5022.7 5023.7 5032.1 5058.7 4770.7 4774.4 4829.2 4866.3 4988.5 4992.4 4996.7 4997.4 5020.9 5036.4 4861.1 4885.4 4895.5 4896.8 4943.1 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#1] ext.html Cycles:180 Average:46725.72 Median:33873.58 stddev:84006.41 (248.0%) stddev-sans-first:84170.57 06:44:01 INFO - PROCESS | 7241 | Values: 562.4 598.7 599.4 600.4 613.8 27767.9 30435.4 30517.5 30521.5 41674.8 39902.6 40069.8 40124.0 40435.6 40544.8 7644.7 7853.7 7856.6 7862.1 7863.3 7434.7 7648.5 9947.4 10198.7 10201.3 10234.4 10293.7 10306.3 10321.1 10329.6 7461.0 10097.6 10155.7 10174.7 10178.8 9830.9 10206.5 10215.1 10549.8 10567.6 39687.2 40184.8 40205.0 40263.4 40294.2 3078.4 3120.3 3175.8 3209.9 3220.7 30510.5 30653.7 31062.8 31161.2 31506.0 3503.3 3549.8 3570.9 3604.2 3643.6 248740.8 249343.0 251184.0 251468.0 251709.0 54242.5 54324.5 54757.2 54779.7 54875.0 33348.0 34186.5 34253.8 35964.3 36268.6 12228.7 12327.1 12420.6 12459.5 12650.4 8081.0 8752.9 8785.6 8801.9 8846.4 18145.1 18941.0 19044.1 19101.7 19108.5 7031.0 7078.0 7095.4 7155.7 7185.7 842.5 904.8 930.4 973.1 1002.4 28269.7 28447.9 29245.4 29371.7 29391.0 1006.9 1009.3 1051.2 1057.2 1069.4 14721.9 15049.7 15239.9 15381.4 15687.1 397545.0 397547.0 398186.0 398580.0 405713.0 50603.2 50918.7 51097.5 51265.5 51378.5 1121.5 1188.8 1192.7 1217.4 1234.4 28945.1 29490.7 29780.7 30243.0 30369.8 41895.8 41944.2 42350.0 42403.4 42474.4 287011.0 288835.0 289615.0 289899.0 290411.0 25202.6 25956.5 26084.5 26181.2 26317.5 42849.0 42978.4 43525.0 44393.1 44636.8 36377.3 36842.6 37586.0 37663.2 37665.4 36343.8 36758.8 37001.6 37190.3 37876.0 35225.6 35709.0 36044.5 36457.0 36600.5 31160.2 32636.3 32934.7 33509.7 33560.7 24952.5 25478.5 25652.6 25811.9 26063.3 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#2] jquery.html Cycles:180 Average:24321.80 Median:4478.52 stddev:66501.44 (1484.9%) stddev-sans-first:66663.67 06:44:01 INFO - PROCESS | 7241 | Values: 364.3 367.8 372.2 378.4 384.3 15834.8 16693.2 17024.7 17091.4 17333.4 15229.5 16681.8 17817.2 17894.6 17910.5 5091.3 5240.3 5251.3 5276.2 5279.8 3795.6 3971.8 5197.5 5843.4 6142.8 6195.7 6211.7 6224.6 6230.0 6235.5 5955.4 6180.6 6181.4 6197.2 6202.6 3464.5 5093.2 5397.2 5406.2 5406.2 19959.4 20523.9 20548.7 20860.4 20894.8 1887.5 1951.5 1998.7 2149.3 2388.1 6588.3 7265.9 13175.7 13730.5 13779.0 1612.3 1739.5 1745.7 1747.9 1791.1 67390.3 67845.0 68300.3 68522.3 68882.3 10230.2 10257.3 10291.9 10334.7 10482.0 14172.4 14260.4 14262.8 14267.7 14322.2 6545.0 6649.2 6686.7 6769.2 6785.5 6089.8 6113.4 6145.6 6247.6 6364.1 4345.9 4444.6 4512.5 4532.3 4583.7 1734.3 1768.6 1782.5 1871.1 1878.5 892.9 916.9 970.2 971.9 1008.5 15572.5 16246.3 16606.8 16736.1 17231.2 858.4 861.6 906.6 922.6 937.3 9269.6 9301.5 9538.3 9555.5 9721.1 402505.0 403226.0 403279.0 405517.0 405613.0 72313.0 74172.3 76153.0 76563.0 76598.0 920.9 928.6 938.7 949.9 956.1 14799.9 14811.8 15108.8 15161.4 15190.8 25288.5 25350.1 32107.0 34427.0 34735.1 44076.8 46261.3 47724.5 47856.8 48364.8 7762.6 7921.5 8057.3 8063.5 8070.2 6988.4 11072.8 11429.3 11651.8 11668.8 9243.8 9950.2 10041.3 10146.4 10505.3 9640.1 9856.6 9930.7 10191.8 10208.4 9688.9 10159.0 10331.8 10476.3 10558.4 7487.9 7669.8 7807.0 7921.8 7966.0 8243.0 9391.7 10492.9 10642.6 10702.6 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#3] mootools.html Cycles:180 Average:5066.32 Median:5057.22 stddev:2873.21 (56.8%) stddev-sans-first:2867.22 06:44:01 INFO - PROCESS | 7241 | Values: 1285.3 1402.1 1434.5 1551.6 1748.8 6693.4 7291.1 7518.1 7529.9 7534.1 6875.3 7029.5 7035.6 7226.7 7228.4 1839.5 2089.1 2166.1 2171.2 2218.5 2190.6 2197.4 2197.6 2198.3 2202.0 2135.8 2147.5 2193.8 2194.5 2195.4 1816.2 2077.8 2118.8 2125.4 2125.8 2082.6 2101.2 2102.4 2103.9 2104.1 7606.9 7655.6 7667.8 7669.2 7676.3 4264.4 4384.9 4385.2 4389.2 4392.3 2763.9 2931.8 2931.9 2954.1 2957.8 867.6 867.9 882.1 899.7 908.7 10403.4 10671.0 10684.5 10699.3 10715.9 4141.7 4156.8 4251.2 4251.8 4259.5 9170.6 9179.5 9203.0 9204.3 9213.5 4348.7 4395.1 4402.6 4451.1 4453.1 3500.7 3897.7 3996.4 4008.6 4068.7 3650.3 3694.2 3774.1 3775.3 3842.8 1167.3 1179.2 1204.5 1205.7 1228.3 821.4 828.6 829.8 849.3 850.2 4915.6 5109.4 5148.1 5256.7 5301.2 903.4 908.7 932.1 958.3 971.1 3449.1 3604.5 3637.6 3664.7 3667.5 9567.4 9813.2 9938.2 9979.3 9989.8 9530.9 9849.9 9868.6 9873.7 9875.1 7181.1 7253.1 7389.6 7396.3 7432.1 4815.8 4816.1 4918.8 4952.9 5005.0 8912.7 8912.8 8939.6 9008.5 9042.3 8610.0 9147.7 9150.1 9154.7 9161.3 5700.7 5910.1 6004.4 6055.9 6127.6 7468.8 7510.1 7585.7 7592.5 7595.5 6612.4 6697.4 6757.3 6810.9 6818.0 6646.0 6703.7 6723.8 6794.5 6850.0 6231.8 6266.7 6279.0 6304.2 6313.6 4288.7 4451.7 4464.3 4519.2 4520.6 4620.0 4635.2 4639.0 4641.4 4716.7 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#4] prototype.html Cycles:180 Average:4037.93 Median:4398.57 stddev:1140.65 (25.9%) stddev-sans-first:1108.69 06:44:01 INFO - PROCESS | 7241 | Values: 293.7 296.9 298.1 306.2 309.9 4680.2 4848.4 4851.7 4896.1 4900.1 4594.2 4743.6 4800.2 4802.2 4830.8 3827.3 3828.2 3835.8 3839.9 3869.1 3649.8 3715.9 3812.2 3847.0 3848.1 3792.1 3792.6 3794.0 3803.5 3807.5 3774.5 3778.8 3782.2 3782.5 3796.6 3376.1 3380.2 3381.0 3385.7 3419.5 4497.4 4572.2 4581.0 4582.0 4601.4 4360.6 4364.8 4367.5 4370.6 4386.7 4962.2 4989.6 5022.5 5027.6 5072.9 3592.7 3684.2 3687.5 3688.7 3737.4 5174.9 5202.2 5215.3 5219.7 5228.2 3769.6 3770.8 3786.9 3798.3 3805.2 3722.3 3848.9 3850.6 3861.2 3871.7 4311.1 4336.3 4345.2 4363.8 4364.5 5027.3 5037.9 5043.6 5048.4 5063.3 1273.6 1300.0 1306.3 1347.8 1349.1 849.9 867.5 870.8 872.1 878.4 3959.8 3963.7 3982.1 3985.8 4001.0 4516.0 4534.4 4558.5 4570.7 4597.4 3919.0 3935.8 3971.6 3987.6 3991.0 2333.3 2422.9 2438.1 2445.3 2448.4 4319.8 4361.5 4380.3 4383.9 4397.6 4693.1 4694.8 4697.9 4722.2 4742.7 4172.0 4329.1 4361.8 4388.6 4399.5 4542.5 4571.4 4573.8 4585.0 4629.4 4509.1 4527.8 4590.9 4594.7 4623.7 4157.0 4381.6 4415.3 4421.0 4426.9 3499.5 3506.4 3527.3 3530.8 3533.5 4607.9 4654.7 4675.8 4681.5 5024.5 4856.3 4965.6 4970.9 4985.0 5023.6 4926.3 4929.9 4947.2 4973.6 4983.4 4845.4 4866.0 4903.2 4909.3 4922.0 5012.7 5024.0 5031.5 5033.3 5072.5 4918.1 4931.5 4942.8 4970.9 4978.9 06:44:01 INFO - PROCESS | 7241 | 06:44:01 INFO - PROCESS | 7241 | [#5] yui.html Cycles:180 Average:13566.94 Median:21216.28 stddev:15858.12 (74.7%) stddev-sans-first:15873.04 06:44:01 INFO - PROCESS | 7241 | Values: 672.6 762.1 766.8 771.1 776.3 12531.2 12532.6 12658.6 12689.2 12689.3 11698.1 11890.8 11913.2 11918.1 11953.5 644.6 793.5 803.5 810.0 811.1 816.0 823.8 824.2 824.6 828.9 841.5 843.7 845.9 846.0 846.2 666.4 823.1 836.1 836.4 846.1 616.2 618.0 619.7 620.0 620.6 12726.2 12770.1 12783.4 12790.9 12801.8 11813.0 12553.0 12560.4 12619.0 12962.2 11181.8 11229.7 11592.1 11640.5 11923.9 4071.4 4151.8 4153.3 4162.5 4293.2 44712.1 45220.3 45387.0 45390.5 45467.0 9908.1 9987.5 10196.2 10304.9 10486.4 18050.0 18050.6 18059.6 18065.5 18084.5 6629.7 6703.0 6713.5 6883.5 6888.2 3546.1 3613.6 3617.4 3641.7 3756.1 2515.4 2599.4 2604.9 2606.3 2610.1 421.8 471.8 478.9 479.4 480.9 610.9 612.2 623.6 626.2 644.7 8216.4 8497.0 8632.8 8777.0 8780.2 481.9 516.8 586.5 619.1 659.1 3461.7 3697.2 3697.7 3737.7 3754.2 56981.0 58782.1 59198.4 59332.7 59432.4 51170.2 52395.5 53282.7 54442.0 54765.2 48299.0 48325.8 48376.5 48539.8 49245.5 6982.8 7125.4 7171.3 7242.9 7247.0 30843.8 31220.0 31754.7 31856.4 32143.2 39085.6 39509.4 41281.4 41688.8 42010.8 11015.0 11458.3 11472.9 11498.1 11502.9 12390.4 12430.4 12653.0 12700.4 12729.4 10827.4 11259.3 11285.5 11534.3 12043.8 11663.9 11704.6 11762.8 11870.3 12025.6 10958.8 11002.2 11090.3 11250.8 11356.5 9457.0 9530.1 9828.0 9946.3 10184.8 9671.3 9927.8 10001.5 10030.7 10078.5 06:44:01 INFO - PROCESS | 7241 | -------- Summary: end -------- 06:44:01 INFO - PROCESS | 7241 | 06:44:02 INFO - TEST-INFO | 7241: exit 0 06:44:02 INFO - TEST-OK | dromaeo_css | took 1119425ms 06:44:02 INFO - TEST-START | kraken 06:44:02 INFO - operating with platform_type : linux_ 06:44:02 INFO - Initialising browser for kraken test... 06:44:02 INFO - TEST-INFO | started process 7417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxS6QPg/profile http://localhost:34789/getInfo.html) 06:44:06 INFO - PROCESS | 7417 | __metrics Screen width/height:1600/1200 06:44:06 INFO - PROCESS | 7417 | colorDepth:24 06:44:06 INFO - PROCESS | 7417 | Browser inner width/height: 1024/697 06:44:06 INFO - PROCESS | 7417 | __metrics 06:44:07 ERROR - PROCESS | 7417 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:44:08 INFO - TEST-INFO | 7417: exit 0 06:44:08 INFO - Browser initialized. 06:44:08 INFO - Running cycle 1/1 for kraken test... 06:44:08 INFO - TEST-INFO | started process 7498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxS6QPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:20 INFO - PROCESS | 7498 | RSS: Main: 155369472 06:44:20 INFO - PROCESS | 7498 | 06:44:23 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34789/tests/kraken/driver.html?testName=audio-beat-detection) 06:44:24 INFO - PROCESS | 7498 | RSS: Main: 210378752 06:44:24 INFO - PROCESS | 7498 | 06:44:27 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34789/tests/kraken/driver.html?testName=audio-dft) 06:44:27 INFO - PROCESS | 7498 | RSS: Main: 198311936 06:44:27 INFO - PROCESS | 7498 | 06:44:31 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34789/tests/kraken/driver.html?testName=audio-fft) 06:44:31 INFO - PROCESS | 7498 | RSS: Main: 267251712 06:44:31 INFO - PROCESS | 7498 | 06:44:34 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34789/tests/kraken/driver.html?testName=audio-oscillator) 06:44:34 INFO - PROCESS | 7498 | RSS: Main: 177426432 06:44:34 INFO - PROCESS | 7498 | 06:44:37 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:44:37 INFO - PROCESS | 7498 | RSS: Main: 181133312 06:44:37 INFO - PROCESS | 7498 | 06:44:41 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34789/tests/kraken/driver.html?testName=imaging-darkroom) 06:44:41 INFO - PROCESS | 7498 | RSS: Main: 216764416 06:44:41 INFO - PROCESS | 7498 | 06:44:45 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34789/tests/kraken/driver.html?testName=imaging-desaturate) 06:44:46 INFO - PROCESS | 7498 | RSS: Main: 215728128 06:44:46 INFO - PROCESS | 7498 | 06:44:49 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34789/tests/kraken/driver.html?testName=json-parse-financial) 06:44:49 INFO - PROCESS | 7498 | RSS: Main: 215732224 06:44:49 INFO - PROCESS | 7498 | 06:44:51 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:44:52 INFO - PROCESS | 7498 | RSS: Main: 208678912 06:44:52 INFO - PROCESS | 7498 | 06:44:54 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:44:54 INFO - PROCESS | 7498 | RSS: Main: 210874368 06:44:54 INFO - PROCESS | 7498 | 06:44:57 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:44:57 INFO - PROCESS | 7498 | RSS: Main: 219439104 06:44:57 INFO - PROCESS | 7498 | 06:45:00 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:45:01 INFO - PROCESS | 7498 | RSS: Main: 223834112 06:45:01 INFO - PROCESS | 7498 | 06:45:04 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:45:04 INFO - PROCESS | 7498 | RSS: Main: 222322688 06:45:04 INFO - PROCESS | 7498 | 06:45:06 INFO - PROCESS | 7498 | Cycle 1(1): loaded http://localhost:34789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34789/tests/kraken/driver.html?testName=ai-astar) 06:45:07 INFO - PROCESS | 7498 | RSS: Main: 267919360 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | __start_tp_report 06:45:07 INFO - PROCESS | 7498 | _x_x_mozilla_page_load 06:45:07 INFO - PROCESS | 7498 | _x_x_mozilla_page_load_details 06:45:07 INFO - PROCESS | 7498 | |i|pagename|runs| 06:45:07 INFO - PROCESS | 7498 | |0;ai-astar;114;109;114;113;113;114;112;113;114;114 06:45:07 INFO - PROCESS | 7498 | |1;audio-beat-detection;158;132;132;204;132;163;152;129;191;128 06:45:07 INFO - PROCESS | 7498 | |2;audio-dft;162;162;162;162;162;161;160;162;160;161 06:45:07 INFO - PROCESS | 7498 | |3;audio-fft;74;77;75;137;76;76;74;76;134;76 06:45:07 INFO - PROCESS | 7498 | |4;audio-oscillator;93;94;154;94;94;94;120;93;94;138 06:45:07 INFO - PROCESS | 7498 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 06:45:07 INFO - PROCESS | 7498 | |6;imaging-darkroom;146;146;147;146;145;146;147;145;146;146 06:45:07 INFO - PROCESS | 7498 | |7;imaging-desaturate;94;96;94;95;94;95;95;95;94;95 06:45:07 INFO - PROCESS | 7498 | |8;json-parse-financial;64;66;65;65;66;65;65;119;63;62 06:45:07 INFO - PROCESS | 7498 | |9;json-stringify-tinderbox;65;66;66;66;65;65;64;65;66;66 06:45:07 INFO - PROCESS | 7498 | |10;stanford-crypto-aes;83;82;83;85;84;83;84;85;87;87 06:45:07 INFO - PROCESS | 7498 | |11;stanford-crypto-ccm;139;131;131;131;132;138;129;127;198;142 06:45:07 INFO - PROCESS | 7498 | |12;stanford-crypto-pbkdf2;178;176;181;179;172;178;175;180;177;174 06:45:07 INFO - PROCESS | 7498 | |13;stanford-crypto-sha256-iterative;72;71;69;69;68;68;67;66;70;70 06:45:07 INFO - PROCESS | 7498 | __end_tp_report 06:45:07 INFO - PROCESS | 7498 | __start_cc_report 06:45:07 INFO - PROCESS | 7498 | _x_x_mozilla_cycle_collect,2117 06:45:07 INFO - PROCESS | 7498 | __end_cc_report 06:45:07 INFO - PROCESS | 7498 | __startTimestamp1463838307034__endTimestamp 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | ------- Summary: start ------- 06:45:07 INFO - PROCESS | 7498 | Number of tests: 14 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:1.56 (1.4%) stddev-sans-first:1.62 06:45:07 INFO - PROCESS | 7498 | Values: 114.0 109.0 114.0 113.0 113.0 114.0 112.0 113.0 114.0 114.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:155.00 stddev:27.26 (17.6%) stddev-sans-first:28.83 06:45:07 INFO - PROCESS | 7498 | Values: 158.0 132.0 132.0 204.0 132.0 163.0 152.0 129.0 191.0 128.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 06:45:07 INFO - PROCESS | 7498 | Values: 162.0 162.0 162.0 162.0 162.0 161.0 160.0 162.0 160.0 161.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#3] audio-fft Cycles:10 Average:87.50 Median:76.00 stddev:25.33 (33.3%) stddev-sans-first:26.39 06:45:07 INFO - PROCESS | 7498 | Values: 74.0 77.0 75.0 137.0 76.0 76.0 74.0 76.0 134.0 76.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:94.00 stddev:22.55 (24.0%) stddev-sans-first:23.36 06:45:07 INFO - PROCESS | 7498 | Values: 93.0 94.0 154.0 94.0 94.0 94.0 120.0 93.0 94.0 138.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:45:07 INFO - PROCESS | 7498 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:45:07 INFO - PROCESS | 7498 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 147.0 145.0 146.0 146.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 06:45:07 INFO - PROCESS | 7498 | Values: 94.0 96.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:65.00 stddev:17.26 (26.6%) stddev-sans-first:18.17 06:45:07 INFO - PROCESS | 7498 | Values: 64.0 66.0 65.0 65.0 66.0 65.0 65.0 119.0 63.0 62.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 06:45:07 INFO - PROCESS | 7498 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 64.0 65.0 66.0 66.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.50 stddev:1.70 (2.0%) stddev-sans-first:1.74 06:45:07 INFO - PROCESS | 7498 | Values: 83.0 82.0 83.0 85.0 84.0 83.0 84.0 85.0 87.0 87.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:135.00 stddev:21.00 (15.6%) stddev-sans-first:22.27 06:45:07 INFO - PROCESS | 7498 | Values: 139.0 131.0 131.0 131.0 132.0 138.0 129.0 127.0 198.0 142.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:178.00 stddev:2.79 (1.6%) stddev-sans-first:2.93 06:45:07 INFO - PROCESS | 7498 | Values: 178.0 176.0 181.0 179.0 172.0 178.0 175.0 180.0 177.0 174.0 06:45:07 INFO - PROCESS | 7498 | 06:45:07 INFO - PROCESS | 7498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.83 (2.6%) stddev-sans-first:1.58 06:45:07 INFO - PROCESS | 7498 | Values: 72.0 71.0 69.0 69.0 68.0 68.0 67.0 66.0 70.0 70.0 06:45:07 INFO - PROCESS | 7498 | -------- Summary: end -------- 06:45:07 INFO - PROCESS | 7498 | 06:45:08 INFO - TEST-INFO | 7498: exit 0 06:45:08 INFO - TEST-OK | kraken | took 65880ms 06:45:08 INFO - SUITE-END | took 1185s 06:45:08 INFO - Completed test suite (00:19:45) 06:45:08 INFO - javascript benchmark 06:45:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.4282229320697, 2665.453582015687, 2690.2467309153444, 2708.959365609515, 2718.7824974002083, 4588.2888152336445, 4646.4191976003, 4655.324977878206, 4719.3392924990485, 4757.881052973673, 4662.11419830232, 4706.270528068147, 4717.103750287443, 4723.504032076634, 4727.1727447696685, 4274.551172126937, 4317.481902171744, 4353.172897149548, 4385.583369579885, 4447.822087116511, 4386.100849325897, 4410.25025745624, 4413.051193993291, 4451.221036318648, 4460.353248778925, 4225.9788701056605, 4270.295401258789, 4282.186384586949, 4296.2266791977745, 4348.521662617125, 4299.269124248885, 4300.290452075404, 4310.331898555697, 4328.7835608219775, 4358.564143585648, 4335.458067741532, 4343.782810859444, 4348.695591308609, 4384.868453946355, 4397.296432570805, 4531.705439146445, 4544.2047641662575, 4558.179527685015, 4649.279361698942, 4690.929636055462, 5018.322526458918, 5040.873978150539, 5072.0, 5089.389273287192, 5091.389033315989, 5087.821926232601, 5104.821331253388, 5114.130597798383, 5118.2578526113875, 5120.103981803207, 4599.425071866017, 4697.6241900647865, 4708.9058218835435, 4762.190427627312, 4766.022965292107, 5262.552683021986, 5271.604629652715, 5283.735813209324, 5285.920711189336, 5290.047791397586, 5037.874053148627, 5043.142665746758, 5051.393832740095, 5063.8480845574695, 5065.088284108896, 4898.0, 4975.5522003019905, 5035.0, 5098.872528186751, 5106.004329155853, 5061.392632884003, 5078.923816142761, 5085.949140508547, 5100.770465328995, 5141.0, 5049.343585333883, 5066.290719299301, 5067.41724701664, 5067.5185857343495, 5116.411612664591, 4220.767857767853, 4221.0, 4265.786710664454, 4322.286822674224, 4373.365861949999, 3733.4026555750947, 3747.8875633730486, 3753.7184711146774, 3765.1340191755503, 3819.789911554891, 4277.465316835395, 4304.526502084768, 4311.762853043113, 4346.369776382407, 4346.456692913386, 4974.626902982291, 4990.3762029746285, 5035.597152227813, 5071.923921141186, 5112.846614601568, 4245.0448649053715, 4325.653947684178, 4331.848385306499, 4333.1766964276685, 4334.306510958295, 4525.977370113128, 4544.409226800495, 4549.067441174618, 4576.6109880660515, 4589.472210695746, 4737.692050016738, 4740.674246957882, 4741.0754902794315, 4744.715317080986, 4803.447603525639, 4930.8767280818265, 4988.4263309719845, 5043.167877300204, 5058.54473097423, 5081.110805609078, 4746.0, 4769.73766442849, 4788.7366194859615, 4792.137415265286, 4843.951560484491, 5009.373828271466, 5012.498750124958, 5015.473375295542, 5018.99620075979, 5069.03688299222, 4909.803607855646, 5069.569086627531, 5072.873178170576, 5102.744862756922, 5138.229265610188, 4998.4251811042195, 5016.899662006666, 5018.623603229699, 5025.547700706954, 5055.5702765263895, 5014.824481143142, 5022.698638081727, 5023.6985780853265, 5032.144535429059, 5058.747062646927, 4770.689905156154, 4774.355462012584, 4829.1790395633525, 4866.294387313749, 4988.45127036033, 4992.375953005874, 4996.675216110941, 4997.350344455343, 5020.899582008413, 5036.420811606712, 4861.149298872612, 4885.389326334208, 4895.510448955076, 4896.804127834846, 4943.060818444484], "value": 4651.18706826268, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.4150883081595, 598.7365559153975, 599.4155698194261, 600.3786081405746, 613.7514306705784, 27767.861160694192, 30435.391292174143, 30517.542236866466, 30521.542176867366, 41674.7916260419, 39902.60097399025, 40069.79965100178, 40124.0, 40435.59564404355, 40544.797276013654, 7644.655990480428, 7853.685852565891, 7856.646450909694, 7862.135165131859, 7863.292303692667, 7434.665440055183, 7648.502847314934, 9947.403155810674, 10198.745031374201, 10201.285909986304, 10234.385936843813, 10293.691189264335, 10306.330088544259, 10321.071103600674, 10329.63846265381, 7461.0, 10097.596096156145, 10155.7461063474, 10174.745631359237, 10178.796424071552, 9830.852537211947, 10206.540705668189, 10215.131713804336, 10549.84175237372, 10567.63013294531, 39687.20625587501, 40184.78059803737, 40205.0, 40263.39604905929, 40294.19411611751, 3078.3843231353594, 3120.329129237225, 3175.7618178636462, 3209.935801283985, 3220.6940340667834, 30510.54234186489, 30653.69346306553, 31062.844685776654, 31161.22096947572, 31506.0, 3503.281827225438, 3549.791276239197, 3570.8571657133684, 3604.153024039375, 3643.599204087575, 248740.75629621916, 249343.0, 251184.0, 251468.0, 251708.99999999817, 54242.45757542453, 54324.45675543273, 54757.178642320396, 54779.72610137003, 54875.0, 33348.0, 34186.48720269148, 34253.828730856185, 35964.28071438557, 36268.637313626525, 12228.694282643006, 12327.137100402886, 12420.565280215149, 12459.501619935283, 12650.367481625883, 8081.0, 8752.912470875337, 8785.560721963877, 8801.911980880237, 8846.363422766808, 18145.092745362945, 18941.0, 19044.143013564422, 19101.713474297896, 19108.522286942938, 7031.0, 7078.0, 7095.3968912643, 7155.7495487658725, 7185.712571497082, 842.4818736477023, 904.7602385367883, 930.4091901642506, 973.1047436358567, 1002.4336250018862, 28269.71730282671, 28447.857760711064, 29245.415091698047, 29371.706282937324, 29391.0, 1006.9144122749502, 1009.333839665817, 1051.164324362134, 1057.2070946789909, 1069.4438891776388, 14721.92639036798, 15049.699006020037, 15239.923800380928, 15381.384744610314, 15687.058776473448, 397545.0, 397547.0, 398186.0, 398580.0, 405713.0, 50603.24095138576, 50918.745406273476, 51097.48902510927, 51265.487345126814, 51378.48621513812, 1121.4616983847798, 1188.7563049574817, 1192.6720151958107, 1217.3973882928008, 1234.4321612058554, 28945.131646050653, 29490.705092948796, 29780.70219297866, 30243.0, 30369.848150759106, 41895.7905210472, 41944.1611167781, 42350.0, 42403.363949541395, 42474.36288455738, 287011.0, 288835.0, 289615.0, 289899.0, 290411.0, 25202.621960670236, 25956.480870382864, 26084.478310433304, 26181.214563563124, 26317.4736505265, 42849.0, 42978.35532466953, 43525.0, 44393.11213775642, 44636.776816115715, 36377.27245455023, 36842.631573684994, 37586.0, 37663.2467350646, 37665.4350184742, 36343.818280908425, 36758.816205918796, 37001.62998370089, 37190.25619487649, 37876.0, 35225.64774352223, 35709.0, 36044.45933311055, 36457.0, 36600.45099323459, 31160.22099447532, 32636.347273054882, 32934.67065329412, 33509.664903350655, 33560.66439335673, 24952.500949981262, 25478.490430191665, 25652.56885038087, 25811.870940645178, 26063.348416288987], "value": 17759.681702393584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.3205421888179, 367.77381910125274, 372.22948496612014, 378.38701303887706, 384.31783584138134, 15834.841651583482, 16693.165341732896, 17024.744628830576, 17091.40180093697, 17333.393331233427, 15229.4669686561, 16681.83318166821, 17817.198226079858, 17894.642107157848, 17910.462686119437, 5091.338126043609, 5240.34495688039, 5251.343582052244, 5276.182191760283, 5279.815206467774, 3795.601461846508, 3971.8212680429306, 5197.506236907488, 5843.386444423338, 6142.785002524913, 6195.721192546346, 6211.658358790265, 6224.595401298924, 6230.0, 6235.5011599072195, 5955.374685658008, 6180.598261113036, 6181.412765787243, 6197.16338294329, 6202.596831205957, 3464.4630082337276, 5093.2105523643895, 5397.217403476513, 5406.162044883049, 5406.189071639246, 19959.401217963485, 20523.89738051315, 20548.691769623467, 20860.37418877436, 20894.791052089437, 1887.5092475956212, 1951.4633475794128, 1998.7401637786995, 2149.258505815491, 2388.10446082719, 6588.308227636077, 7265.927340726631, 13175.670608234776, 13730.45078196871, 13779.0, 1612.3389410341822, 1739.4868513788335, 1745.729411941151, 1747.8863873848159, 1791.0596936608254, 67390.32609673939, 67844.98232526565, 68300.31699682989, 68522.31477685209, 68882.31117688809, 10230.23273254509, 10257.33327333721, 10291.897081029243, 10334.741631459274, 10481.956018576304, 14172.362243699059, 14260.429582816778, 14262.786058209134, 14267.714645707236, 14322.212278324583, 6545.0, 6649.202095748541, 6686.732530698815, 6769.22153952292, 6785.457163427012, 6089.847753806191, 6113.419225173601, 6145.569810113249, 6247.5939063960695, 6364.07720880479, 4345.935245864784, 4444.577765112309, 4512.458504979423, 4532.252178390595, 4583.656225783079, 1734.2976094681674, 1768.5755418699678, 1782.4563508130145, 1871.0644677661169, 1878.483417060292, 892.8883889513811, 916.867054277126, 970.1705042188968, 971.8639390485338, 1008.5058321422597, 15572.532824015298, 16246.268917898722, 16606.83393166077, 16736.079515626756, 17231.22459489326, 858.4290051296407, 861.5735211070435, 906.5648488725449, 922.5940586142076, 937.315759495572, 9269.629214831331, 9301.53492325381, 9538.284628652878, 9555.522223888778, 9721.076497732704, 402505.0, 403225.9516107261, 403279.0, 405517.0, 405613.0, 72313.0, 74172.25827741761, 76153.0, 76563.0, 76598.0, 920.9309301802392, 928.5867788833904, 938.6949241496541, 949.9097585729345, 956.1012648110753, 14799.92600036993, 14811.777823332874, 15108.773368399263, 15161.442200470821, 15190.772138418153, 25288.494230115663, 25350.1127460538, 32107.0, 34427.0, 34735.13162170966, 44076.77961610172, 46261.30608040949, 47724.522754772006, 47856.76071619619, 48364.758176208896, 7762.611869406394, 7921.524708517277, 8057.274845263954, 8063.475874068166, 8070.192980701883, 6988.37104660583, 11072.833907491555, 11429.257098288585, 11651.825222621837, 11668.766624667629, 9243.815123697623, 9950.154236889655, 10041.347312424961, 10146.441945693057, 10505.31715438494, 9640.084192001748, 9856.5564549594, 9930.702078937644, 10191.796164076528, 10208.387496750218, 9688.9031109688, 10159.0, 10331.84502232452, 10476.266661333633, 10558.366498010144, 7487.887681684888, 7669.769906902802, 7806.960965195365, 7921.801954951173, 7966.0440747110715, 8243.0, 9391.718248452557, 10492.895071049192, 10642.574297028032, 10702.571897124028], "value": 8195.230645622101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.338050903784, 1402.1376853235263, 1434.540946896993, 1551.6353656890628, 1748.8426041656248, 6693.36413040761, 7291.08861392326, 7518.135414427343, 7529.924700752991, 7534.095908490982, 6875.346842050009, 7029.543079699816, 7035.577865328084, 7226.674799634016, 7228.4217262618995, 1839.475749411418, 2089.0808044460464, 2166.068590506082, 2171.174953517661, 2218.4786575154826, 2190.561887622474, 2197.3847322749657, 2197.637389830684, 2198.307533127068, 2201.966970495444, 2135.754388245356, 2147.5382792699565, 2193.758686544487, 2194.462356722597, 2195.3523710505438, 1816.1917946513806, 2077.781832907553, 2118.798714122156, 2125.447383680239, 2125.80867721905, 2082.562661841015, 2101.233049936762, 2102.3797979596056, 2103.8527303088636, 2104.116271166114, 7606.885896711554, 7655.578943158124, 7667.808304792425, 7669.156392796788, 7676.347510461617, 4264.360345948133, 4384.89037774055, 4385.188740083063, 4389.1660584488845, 4392.253316936129, 2763.903263385772, 2931.809432386888, 2931.868065937038, 2954.084233887502, 2957.8077424967523, 867.6139118092451, 867.8654808504692, 882.1266945723752, 899.6716198587468, 908.7273817854617, 10403.427811470367, 10671.0, 10684.465776711211, 10699.251052426333, 10715.892841071567, 4141.689373297015, 4156.792160392029, 4251.213525497793, 4251.808668609858, 4259.488861336659, 9170.587323570455, 9179.541022948959, 9203.0, 9204.309676774268, 9213.493257870747, 4348.695591308641, 4395.055063161436, 4402.559744025636, 4451.109778044404, 4453.064856380196, 3500.68493835556, 3897.7466464679705, 3996.360582306817, 4008.5590585035625, 4068.7151899367354, 3650.2881938021833, 3694.1872787987136, 3774.1319496515957, 3775.2638235544355, 3842.7886466244627, 1167.311286341063, 1179.1569028144745, 1204.476052916984, 1205.6503613952032, 1228.2630421747058, 821.4250024982537, 828.6436832162228, 829.7966998085508, 849.3332733803934, 850.2262940723912, 4915.58217551505, 5109.412417571953, 5148.073346797538, 5256.658317209446, 5301.231321458367, 903.3541018172039, 908.6910450446748, 932.0613124700742, 958.2860768727203, 971.0823272008026, 3449.137715571107, 3604.513390692223, 3637.5816781069984, 3664.688501477351, 3667.5048868402423, 9567.37812042215, 9813.214942804558, 9938.204943604494, 9979.301448898652, 9989.750256243507, 9530.857037144448, 9849.901500985041, 9868.555914983843, 9873.703788886345, 9875.111239988435, 7181.102362204724, 7253.093363329584, 7389.556626602421, 7396.260373962561, 7432.145303290083, 4815.759212039454, 4816.133096042746, 4918.827841025547, 4952.925706114339, 5005.024020316004, 8912.688055918012, 8912.821743565222, 8939.553022348986, 9008.504532250527, 9042.276617870422, 8610.0, 9147.71931929517, 9150.084991500797, 9154.725358239264, 9161.31290153228, 5700.743466544099, 5910.054391297372, 6004.39956004396, 6055.878882422415, 6127.590654149481, 7468.813279668052, 7510.061242344707, 7585.658645360862, 7592.506487078323, 7595.506292091218, 6612.404883560503, 6697.397234248746, 6757.3242675732035, 6810.897836532356, 6817.965910170417, 6646.0, 6703.698333574904, 6723.798286051427, 6794.524383293122, 6850.006749021463, 6231.75072997075, 6266.68666566679, 6278.968605157128, 6304.211973503312, 6313.558050936574, 4288.742675439484, 4451.710638808467, 4464.330350447459, 4519.186546421675, 4520.5931466166885, 4620.0, 4635.1656701794, 4638.953610463987, 4641.396618439581, 4716.740579268036], "value": 4082.291762497149, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7473772555603, 296.8842151560891, 298.05367956737354, 306.17333200359036, 309.8791471326183, 4680.227762419197, 4848.424262114813, 4851.708897466155, 4896.114995726649, 4900.093482705697, 4594.218982772928, 4743.596794272482, 4800.159972004903, 4802.23164293713, 4830.758462076891, 3827.272818164554, 3828.1960788234364, 3835.76985380878, 3839.9424008639894, 3869.1294458746697, 3649.835757390924, 3715.9071023224365, 3812.237552489499, 3847.0377809086986, 3848.1149335652817, 3792.146766977422, 3792.639699228569, 3793.951266316186, 3803.50554427924, 3807.4669546263544, 3774.4904437900805, 3778.792166430845, 3782.224643947984, 3782.451544526056, 3796.620337966209, 3376.0547046826928, 3380.171857894807, 3381.0364046246946, 3385.712214461774, 3419.4699821527456, 4497.437820272466, 4572.245579479382, 4580.9541904580865, 4581.954180458186, 4601.401817763669, 4360.585744354281, 4364.803583838735, 4367.497737760166, 4370.562943705604, 4386.6929314947965, 4962.230854217602, 4989.627852340599, 5022.522860328263, 5027.5977921766535, 5072.873178170576, 3592.7305452090936, 3684.1710615111388, 3687.483752274684, 3688.7498625838216, 3737.4206997915367, 5174.922376164361, 5202.245674377232, 5215.322008138955, 5219.739013049332, 5228.241904923765, 3769.6418840210135, 3770.775242606875, 3786.9431958520645, 3798.2973149967343, 3805.2009078093356, 3722.2927643747603, 3848.942265866014, 3850.557185923599, 3861.189150278473, 3871.6515513603913, 4311.1377724454605, 4336.262835318003, 4345.152695224464, 4363.781810909505, 4364.4980827204645, 5027.296178535008, 5037.874053148627, 5043.596512279082, 5048.3941926969, 5063.291139240509, 1273.554256010389, 1299.9805002924963, 1306.2619619914908, 1347.764141275273, 1349.1365526063328, 849.9405041647026, 867.4968518259394, 870.7779516223322, 872.055316643875, 878.3544095090103, 3959.7822119783687, 3963.69198164605, 3982.0841206522664, 3985.7608543487486, 4001.0, 4515.9774201128785, 4534.36518887356, 4558.495696420174, 4570.657200709894, 4597.367934383313, 3919.0, 3935.842566297373, 3971.5631280559114, 3987.6211759883345, 3990.980045099814, 2333.3349995251274, 2422.9394265143515, 2438.1466486729855, 2445.3275349279093, 2448.424620214248, 4319.827206911688, 4361.520232774392, 4380.255356589388, 4383.865536141674, 4397.648188144941, 4693.084848454587, 4694.765261736899, 4697.906041879143, 4722.220833562424, 4742.71946574423, 4172.0, 4329.095198112883, 4361.825526978885, 4388.5830846069575, 4399.49405818335, 4542.477615074309, 4571.428571428572, 4573.81704731807, 4584.977075114603, 4629.351890735367, 4509.143262780061, 4527.818887244473, 4590.9370207366055, 4594.701344412602, 4623.6763426561165, 4157.0, 4381.583749543788, 4415.315626077963, 4421.0, 4426.911461770811, 3499.492573576766, 3506.4389697649276, 3527.2945410918433, 3530.752847300767, 3533.5406397168204, 4607.884802879955, 4654.6741728078705, 4675.812967481399, 4681.531846815291, 5024.547790698854, 4856.295837103671, 4965.577925876341, 4970.9254361183885, 4984.950150498594, 5023.648344615842, 4926.285688575208, 4929.926051109308, 4947.208446648519, 4973.577245933991, 4983.401991761012, 4845.41854977405, 4865.9756701216265, 4903.166461701448, 4909.288153217692, 4922.0, 5012.724300163526, 5023.974880125576, 5031.547160755549, 5033.3456650636645, 5072.51811077947, 4918.1393256180745, 4931.48219436954, 4942.827001054946, 4970.850874473772, 4978.859090590936], "value": 3682.0194920748836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5863593889758, 762.1235579084056, 766.8082979255184, 771.1093686791754, 776.2819392062341, 12531.248125112488, 12532.624021279365, 12658.556950506734, 12689.238645681266, 12689.302088385135, 11698.064154867612, 11890.821637675443, 11913.166078374517, 11918.10614203936, 11953.462094205759, 644.5552568727586, 793.4961299574754, 803.48576910777, 810.0481933727846, 811.1199348706631, 815.963281652327, 823.7858156879224, 824.1593574553951, 824.5794644731201, 828.9378296627747, 841.5245386356689, 843.6836186430089, 845.8519759042174, 846.0017179727919, 846.2003406780594, 666.4435196610835, 823.1192623892438, 836.0510820219096, 836.4145098431122, 846.090452763282, 616.214326733414, 617.9536534759866, 619.683961179797, 619.981400557984, 620.5532016947791, 12726.23642581448, 12770.106092573524, 12783.360831958458, 12790.936045319806, 12801.807972880415, 11813.0, 12553.0, 12560.434780434902, 12619.0, 12962.22226666403, 11181.798737570924, 11229.719257018558, 11592.07263418933, 11640.4761785719, 11923.94038029813, 4071.3689378146437, 4151.750894946283, 4153.252414565377, 4162.542120366757, 4293.205756934945, 44712.10575788499, 45220.32169517493, 45387.0, 45390.546094538964, 45467.0, 9908.108270255712, 9987.534280727998, 10196.184305255561, 10304.896951030543, 10486.370817750807, 18050.0, 18050.638987220445, 18059.638807223782, 18065.458036258933, 18084.45746627603, 6629.734810607618, 6703.0, 6713.4964877634375, 6883.483738719616, 6888.207856096613, 3546.13119785649, 3613.602503724588, 3617.439296908983, 3641.6904563111902, 3756.1360886996144, 2515.421453065805, 2599.3891435512637, 2604.921852344433, 2606.2962999990277, 2610.1256079213294, 421.77435072236204, 471.77354869662065, 478.91140139074383, 479.3792039309103, 480.9495003024702, 610.8961476548998, 612.1582823617526, 623.6102435977514, 626.1765778001912, 644.6841047886502, 8216.380967558782, 8496.957515212385, 8632.827343453097, 8777.034526202113, 8780.165884240987, 481.9229023133294, 516.7803683434526, 586.4575267877282, 619.0806652121596, 659.0542571410042, 3461.653834616518, 3697.1681371691157, 3697.6856967157555, 3737.663610275088, 3754.249150169977, 56981.0, 58782.11826822601, 59198.40801592015, 59332.70333648391, 59432.405675943555, 51170.232446513335, 52395.47604523982, 53282.73358633182, 54442.0, 54765.178522322196, 48299.03401931941, 48325.75837120792, 48376.5162348379, 48539.75730121327, 49245.50754492481, 6982.825429364307, 7125.394341480825, 7171.282871712787, 7242.89135662955, 7247.0, 30843.845780770953, 31220.0, 31754.682453175174, 31856.362872741953, 32143.196420089684, 39085.609143908194, 39509.40735888907, 41281.380779287734, 41688.79155604202, 42010.78994605008, 11015.0, 11458.312501249951, 11472.88527114718, 11498.137639677225, 11502.88497115018, 12390.442430090487, 12430.440630171483, 12653.0, 12700.36498175069, 12729.363531823186, 10827.350358978487, 11259.324440533266, 11285.548578056785, 11534.307941523535, 12043.75912481763, 11663.941680291884, 11704.590339338083, 11762.82355764647, 11870.287782733063, 12025.579104731642, 10958.780824383308, 11002.22984391117, 11090.334579925231, 11250.83123753128, 11356.545738170711, 9456.952715236379, 9530.137636449817, 9827.950860245654, 9946.30375873711, 10184.847227291448, 9671.323007389416, 9927.801443971224, 10001.5499302533, 10030.699079027641, 10078.496075196064], "value": 6100.328996079744, "unit": "score"}], "name": "dromaeo_css", "value": 6292.539673504459, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 132.0, 204.0, 132.0, 163.0, 152.0, 129.0, 191.0, 128.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 160.0, 162.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 137.0, 76.0, 76.0, 74.0, 76.0, 134.0, 76.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 154.0, 94.0, 94.0, 94.0, 120.0, 93.0, 94.0, 138.0], "value": 106.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 119.0, 63.0, 62.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 64.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 85.0, 84.0, 83.0, 84.0, 85.0, 87.0, 87.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 131.0, 131.0, 132.0, 138.0, 129.0, 127.0, 198.0, 142.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 181.0, 179.0, 172.0, 178.0, 175.0, 180.0, 177.0, 174.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 69.0, 68.0, 68.0, 67.0, 66.0, 70.0, 70.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1584.0, "alertThreshold": 2.0}]} 06:45:08 INFO - Return code: 0 06:45:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:45:08 ERROR - # TBPL SUCCESS # 06:45:08 INFO - Running post-action listener: _resource_record_post_action 06:45:08 INFO - ##### 06:45:08 INFO - ##### Finished run-tests step (success) 06:45:08 INFO - ##### 06:45:08 INFO - Running post-run listener: _resource_record_post_run 06:45:08 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 295788544; Read time: 240; Write time: 215532 06:45:08 INFO - TinderboxPrint: CPU usage
13.2% 06:45:08 INFO - TinderboxPrint: I/O read bytes / time
3,305,472 / 240 06:45:08 INFO - TinderboxPrint: I/O write bytes / time
295,788,544 / 215,532 06:45:08 INFO - TinderboxPrint: CPU idle
8,329.8 (86.8%) 06:45:08 INFO - TinderboxPrint: CPU user
1,220.0 (12.7%) 06:45:08 INFO - TinderboxPrint: Swap in / out
0 / 0 06:45:08 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5312512; Read time: 0; Write time: 284 06:45:08 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 3305472; Write bytes: 290476032; Read time: 240; Write time: 215248 06:45:08 INFO - Running post-run listener: _upload_blobber_files 06:45:08 INFO - Blob upload gear active. 06:45:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:45:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:45:08 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:45:08 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:45:09 INFO - (blobuploader) - INFO - Open directory for files ... 06:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:10 INFO - (blobuploader) - INFO - Done attempting. 06:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:13 INFO - (blobuploader) - INFO - Done attempting. 06:45:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:45:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:45:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:45:14 INFO - (blobuploader) - INFO - Done attempting. 06:45:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:45:14 INFO - Return code: 0 06:45:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:45:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:45:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dd9e633ec23ded3926149783b1fa8a9073c2adf55459d44d47c1a914dd5614b8571a74c880426c0dd0a36e985b5c31e2a19d9345d298f90bf8c4dad3442f821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e068b2edd6a0329d071898f18bbc16e1e9909ef75cce10de751ab9a308bfa0bbf8b2853e86cd6c0db988bd838cc15cb957345b7027dc9c14bd7492a4441e675c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d021644a77229e13e8332d20a643e721dee914dc475409949d65cadac20e8da7765c35f632df7ba2b330e2734941ba20746d2545f3d43a1c2d6d6e44688c9a"} 06:45:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:45:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:45:14 INFO - Contents: 06:45:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3dd9e633ec23ded3926149783b1fa8a9073c2adf55459d44d47c1a914dd5614b8571a74c880426c0dd0a36e985b5c31e2a19d9345d298f90bf8c4dad3442f821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e068b2edd6a0329d071898f18bbc16e1e9909ef75cce10de751ab9a308bfa0bbf8b2853e86cd6c0db988bd838cc15cb957345b7027dc9c14bd7492a4441e675c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d021644a77229e13e8332d20a643e721dee914dc475409949d65cadac20e8da7765c35f632df7ba2b330e2734941ba20746d2545f3d43a1c2d6d6e44688c9a"} 06:45:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:45:14 INFO - Copying logs to upload dir... 06:45:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:45:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.047590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-05-21 06:45:14.623424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 06:45:14.630915) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 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-Non-PGO/sha512/3dd9e633ec23ded3926149783b1fa8a9073c2adf55459d44d47c1a914dd5614b8571a74c880426c0dd0a36e985b5c31e2a19d9345d298f90bf8c4dad3442f821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e068b2edd6a0329d071898f18bbc16e1e9909ef75cce10de751ab9a308bfa0bbf8b2853e86cd6c0db988bd838cc15cb957345b7027dc9c14bd7492a4441e675c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d021644a77229e13e8332d20a643e721dee914dc475409949d65cadac20e8da7765c35f632df7ba2b330e2734941ba20746d2545f3d43a1c2d6d6e44688c9a"} build_url:https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/ZY3ez67AQcK64lAXVqSUyg/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-Non-PGO/sha512/3dd9e633ec23ded3926149783b1fa8a9073c2adf55459d44d47c1a914dd5614b8571a74c880426c0dd0a36e985b5c31e2a19d9345d298f90bf8c4dad3442f821", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e068b2edd6a0329d071898f18bbc16e1e9909ef75cce10de751ab9a308bfa0bbf8b2853e86cd6c0db988bd838cc15cb957345b7027dc9c14bd7492a4441e675c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d021644a77229e13e8332d20a643e721dee914dc475409949d65cadac20e8da7765c35f632df7ba2b330e2734941ba20746d2545f3d43a1c2d6d6e44688c9a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 06:45:14.656131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:45:14.656445) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463835873.84291-920943797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:45:14.740290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 06:45:14.740624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 06:45:14.740905) ========= ========= Total master_lag: 0.19 =========