builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1464791071.63 results: success (0) buildid: 20160601060544 builduid: 96bf6103b1444caf9290d603e8ac23f7 revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.630473) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.631032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.631351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.646895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.647325) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-01 07:24:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2016-06-01 07:24:31 (13.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.777773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.778395) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.831591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:31.832291) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --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 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a --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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-01 07:24:31,894 truncating revision to first 12 chars 2016-06-01 07:24:31,895 Setting DEBUG logging. 2016-06-01 07:24:31,895 attempt 1/10 2016-06-01 07:24:31,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/78e2125dfb6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-01 07:24:32,170 unpacking tar archive at: mozilla-central-78e2125dfb6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:32.458264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:32.458589) ========= script_repo_revision: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:32.458985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:32.459251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-01 07:24:32.469137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-01 07:24:32.469424) ========= /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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:24:32 INFO - MultiFileLogger online at 20160601 07:24:32 in /builds/slave/test 07:24:32 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 07:24:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:32 INFO - {'append_to_log': False, 07:24:32 INFO - 'base_work_dir': '/builds/slave/test', 07:24:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:24:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:32 INFO - 'branch': 'Firefox-Non-PGO', 07:24:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:32 INFO - 'config_files': ('talos/linux_config.py',), 07:24:32 INFO - 'default_actions': ('clobber', 07:24:32 INFO - 'read-buildbot-config', 07:24:32 INFO - 'download-and-extract', 07:24:32 INFO - 'populate-webroot', 07:24:32 INFO - 'create-virtualenv', 07:24:32 INFO - 'install', 07:24:32 INFO - 'run-tests'), 07:24:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:32 INFO - 'download_minidump_stackwalk': True, 07:24:32 INFO - 'download_symbols': 'ondemand', 07:24:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:32 INFO - 'installer_path': 'installer.exe', 07:24:32 INFO - 'log_level': 'info', 07:24:32 INFO - 'log_name': 'talos', 07:24:32 INFO - 'log_to_console': True, 07:24:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:24:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:24:32 INFO - 'opt_config_files': (), 07:24:32 INFO - 'pip_index': False, 07:24:32 INFO - 'sps_profile': False, 07:24:32 INFO - 'sps_profile_interval': 0, 07:24:32 INFO - 'suite': 'dromaeojs', 07:24:32 INFO - 'system_bits': '32', 07:24:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:32 INFO - 'title': 'talos-linux64-ix-046', 07:24:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:32 INFO - 'use_talos_json': True, 07:24:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:32 INFO - 'work_dir': 'build'} 07:24:32 INFO - ##### 07:24:32 INFO - ##### Running clobber step. 07:24:32 INFO - ##### 07:24:32 INFO - Running pre-action listener: _resource_record_pre_action 07:24:32 INFO - Running main action method: clobber 07:24:32 INFO - rmtree: /builds/slave/test/build 07:24:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:33 INFO - Running post-action listener: _resource_record_post_action 07:24:33 INFO - ##### 07:24:33 INFO - ##### Finished clobber step (success) 07:24:33 INFO - ##### 07:24:33 INFO - ##### 07:24:33 INFO - ##### Running read-buildbot-config step. 07:24:33 INFO - ##### 07:24:33 INFO - Running pre-action listener: _resource_record_pre_action 07:24:33 INFO - Running main action method: read_buildbot_config 07:24:33 INFO - Using buildbot properties: 07:24:33 INFO - { 07:24:33 INFO - "project": "", 07:24:33 INFO - "product": "firefox", 07:24:33 INFO - "script_repo_revision": "production", 07:24:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:24:33 INFO - "repository": "", 07:24:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:24:33 INFO - "buildid": "20160601060544", 07:24:33 INFO - "pgo_build": "False", 07:24:33 INFO - "basedir": "/builds/slave/test", 07:24:33 INFO - "buildnumber": 601, 07:24:33 INFO - "slavename": "talos-linux64-ix-046", 07:24:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:24:33 INFO - "platform": "ubuntu64_hw", 07:24:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:24:33 INFO - "branch": "mozilla-central", 07:24:33 INFO - "repo_path": "mozilla-central", 07:24:33 INFO - "revision": "78e2125dfb6b02cdbab73a30c54bb4dc19aa310a", 07:24:33 INFO - "stage_platform": "linux64", 07:24:33 INFO - "builduid": "96bf6103b1444caf9290d603e8ac23f7", 07:24:33 INFO - "slavebuilddir": "test" 07:24:33 INFO - } 07:24:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:24:33 INFO - Running post-action listener: _resource_record_post_action 07:24:33 INFO - ##### 07:24:33 INFO - ##### Finished read-buildbot-config step (success) 07:24:33 INFO - ##### 07:24:33 INFO - ##### 07:24:33 INFO - ##### Running download-and-extract step. 07:24:33 INFO - ##### 07:24:33 INFO - Running pre-action listener: _resource_record_pre_action 07:24:33 INFO - Running main action method: download_and_extract 07:24:33 INFO - mkdir: /builds/slave/test/build/tests 07:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:33 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:33 INFO - Downloaded 1361 bytes. 07:24:33 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:24:33 INFO - Using the following test package requirements: 07:24:33 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:33 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:24:33 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:24:33 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'jsshell-linux-x86_64.zip'], 07:24:33 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:24:33 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:24:33 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:24:33 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:24:33 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:24:33 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:24:33 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:24:33 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:33 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:34 INFO - Downloaded 22840484 bytes. 07:24:34 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'] 07:24:34 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 07:24:36 INFO - Return code: 0 07:24:36 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 07:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:36 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:37 INFO - Downloaded 22840484 bytes. 07:24:37 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'] 07:24:37 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 07:24:38 INFO - Return code: 0 07: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')]} 07:24:38 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:39 INFO - Downloaded 10834055 bytes. 07:24:39 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'] 07:24:39 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 07:24:39 INFO - Return code: 0 07:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:39 INFO - https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W_XOc2RaSKmg076k0GtNtg/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 07:24:41 INFO - Downloaded 55033936 bytes. 07:24:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:24:41 INFO - mkdir: /builds/slave/test/properties 07:24:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:24:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:24:41 INFO - Contents: 07:24:41 INFO - build_url:https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:24:42 INFO - Running post-action listener: _resource_record_post_action 07:24:42 INFO - Running post-action listener: set_extra_try_arguments 07:24:42 INFO - ##### 07:24:42 INFO - ##### Finished download-and-extract step (success) 07:24:42 INFO - ##### 07:24:42 INFO - ##### 07:24:42 INFO - ##### Running populate-webroot step. 07:24:42 INFO - ##### 07:24:42 INFO - Running pre-action listener: _resource_record_pre_action 07:24:42 INFO - Running main action method: populate_webroot 07:24:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:42 INFO - '--tppagecycles', 07:24:42 INFO - '7'], 07:24:42 INFO - 'tests': ['tsvgm']}}, 07:24:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:24:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:24:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['damp', 'tps']}, 07:24:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'tests': ['damp', 'tps']}, 07:24:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['dromaeo_dom']}, 07:24:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['a11yr', 07:24:42 INFO - 'ts_paint', 07:24:42 INFO - 'tpaint', 07:24:42 INFO - 'sessionrestore', 07:24:42 INFO - 'sessionrestore_no_auto_restore', 07:24:42 INFO - 'tabpaint']}, 07:24:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['tsvgx', 07:24:42 INFO - 'tsvgr_opacity', 07:24:42 INFO - 'tart', 07:24:42 INFO - 'tscrollx', 07:24:42 INFO - 'cart']}, 07:24:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:24:42 INFO - 'tsvgr_opacity', 07:24:42 INFO - 'tart', 07:24:42 INFO - 'tscrollx', 07:24:42 INFO - 'cart']}, 07:24:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'talos_options': ['--disable-e10s'], 07:24:42 INFO - 'tests': ['tp5o']}, 07:24:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'tests': ['tp5o']}, 07:24:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'talos_options': ['--disable-e10s', 07:24:42 INFO - '--xperf_path', 07:24:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:42 INFO - 'tests': ['tp5n']}, 07:24:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:24:42 INFO - 'talos_options': ['--xperf_path', 07:24:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:42 INFO - 'tests': ['tp5n']}}, 07:24:42 INFO - 'talos.zip': {'path': '', 07:24:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:42 INFO - Running post-action listener: _resource_record_post_action 07:24:42 INFO - ##### 07:24:42 INFO - ##### Finished populate-webroot step (success) 07:24:42 INFO - ##### 07:24:42 INFO - ##### 07:24:42 INFO - ##### Running create-virtualenv step. 07:24:42 INFO - ##### 07:24:42 INFO - Running pre-action listener: _resource_record_pre_action 07:24:42 INFO - Running main action method: create_virtualenv 07:24:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:24:42 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 07:24:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:24:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:42 INFO - Using real prefix '/usr' 07:24:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:24:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:24:44 INFO - Installing pip.................done. 07:24:44 INFO - Return code: 0 07:24:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:24:44 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')]} 07:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:44 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')]} 07:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:44 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:44 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 07:24:44 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 07:24:44 INFO - Using env: {'DISPLAY': ':0', 07:24:44 INFO - 'HOME': '/home/cltbld', 07:24:44 INFO - 'LANG': 'en_US.UTF-8', 07:24:44 INFO - 'LANGUAGE': 'en_US:en', 07:24:44 INFO - 'LOGNAME': 'cltbld', 07:24:44 INFO - 'MAIL': '/var/mail/cltbld', 07:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:44 INFO - 'MOZ_NO_REMOTE': '1', 07:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:44 INFO - 'NO_EM_RESTART': '1', 07:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:44 INFO - 'PWD': '/builds/slave/test', 07:24:44 INFO - 'SHELL': '/bin/bash', 07:24:44 INFO - 'SHLVL': '1', 07:24:44 INFO - 'TERM': 'linux', 07:24:44 INFO - 'TMOUT': '86400', 07:24:44 INFO - 'USER': 'cltbld', 07:24:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:44 INFO - '_': '/tools/buildbot/bin/python'} 07:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:45 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 07:24:45 INFO - Cleaning up... 07:24:45 INFO - Return code: 0 07:24:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:24:45 INFO - Using env: {'DISPLAY': ':0', 07:24:45 INFO - 'HOME': '/home/cltbld', 07:24:45 INFO - 'LANG': 'en_US.UTF-8', 07:24:45 INFO - 'LANGUAGE': 'en_US:en', 07:24:45 INFO - 'LOGNAME': 'cltbld', 07:24:45 INFO - 'MAIL': '/var/mail/cltbld', 07:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:45 INFO - 'MOZ_NO_REMOTE': '1', 07:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:45 INFO - 'NO_EM_RESTART': '1', 07:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:45 INFO - 'PWD': '/builds/slave/test', 07:24:45 INFO - 'SHELL': '/bin/bash', 07:24:45 INFO - 'SHLVL': '1', 07:24:45 INFO - 'TERM': 'linux', 07:24:45 INFO - 'TMOUT': '86400', 07:24:45 INFO - 'USER': 'cltbld', 07:24:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:45 INFO - '_': '/tools/buildbot/bin/python'} 07:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:45 INFO - Downloading/unpacking psutil>=3.1.1 07:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:24:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:47 INFO - Installing collected packages: psutil 07:24:47 INFO - Running setup.py install for psutil 07:24:47 INFO - building 'psutil._psutil_linux' extension 07:24:47 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 07:24:47 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 07:24:47 INFO - building 'psutil._psutil_posix' extension 07:24:47 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 07:24:47 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 07:24:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:47 INFO - Successfully installed psutil 07:24:47 INFO - Cleaning up... 07:24:47 INFO - Return code: 0 07:24:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:47 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:47 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 07:24:47 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 07:24:47 INFO - Using env: {'DISPLAY': ':0', 07:24:47 INFO - 'HOME': '/home/cltbld', 07:24:47 INFO - 'LANG': 'en_US.UTF-8', 07:24:47 INFO - 'LANGUAGE': 'en_US:en', 07:24:47 INFO - 'LOGNAME': 'cltbld', 07:24:47 INFO - 'MAIL': '/var/mail/cltbld', 07:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:47 INFO - 'MOZ_NO_REMOTE': '1', 07:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:47 INFO - 'NO_EM_RESTART': '1', 07:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:47 INFO - 'PWD': '/builds/slave/test', 07:24:47 INFO - 'SHELL': '/bin/bash', 07:24:47 INFO - 'SHLVL': '1', 07:24:47 INFO - 'TERM': 'linux', 07:24:47 INFO - 'TMOUT': '86400', 07:24:47 INFO - 'USER': 'cltbld', 07:24:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:47 INFO - '_': '/tools/buildbot/bin/python'} 07:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:48 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 07:24:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:24:50 INFO - Installing collected packages: mozsystemmonitor 07:24:50 INFO - Running setup.py install for mozsystemmonitor 07:24:50 INFO - Successfully installed mozsystemmonitor 07:24:50 INFO - Cleaning up... 07:24:50 INFO - Return code: 0 07:24:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:50 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:50 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 07:24:50 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 07:24:50 INFO - Using env: {'DISPLAY': ':0', 07:24:50 INFO - 'HOME': '/home/cltbld', 07:24:50 INFO - 'LANG': 'en_US.UTF-8', 07:24:50 INFO - 'LANGUAGE': 'en_US:en', 07:24:50 INFO - 'LOGNAME': 'cltbld', 07:24:50 INFO - 'MAIL': '/var/mail/cltbld', 07:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:50 INFO - 'MOZ_NO_REMOTE': '1', 07:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:50 INFO - 'NO_EM_RESTART': '1', 07:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:50 INFO - 'PWD': '/builds/slave/test', 07:24:50 INFO - 'SHELL': '/bin/bash', 07:24:50 INFO - 'SHLVL': '1', 07:24:50 INFO - 'TERM': 'linux', 07:24:50 INFO - 'TMOUT': '86400', 07:24:50 INFO - 'USER': 'cltbld', 07:24:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:50 INFO - '_': '/tools/buildbot/bin/python'} 07:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:50 INFO - Downloading/unpacking blobuploader==1.2.4 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:50 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 07:24:52 INFO - Downloading blobuploader-1.2.4.tar.gz 07:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:24:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:24:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:52 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 07:24:53 INFO - Downloading docopt-0.6.1.tar.gz 07:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:24:53 INFO - Installing collected packages: blobuploader, requests, docopt 07:24:53 INFO - Running setup.py install for blobuploader 07:24:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:24:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:24:53 INFO - Running setup.py install for requests 07:24:53 INFO - Running setup.py install for docopt 07:24:53 INFO - Successfully installed blobuploader requests docopt 07:24:53 INFO - Cleaning up... 07:24:53 INFO - Return code: 0 07:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:53 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')]} 07:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:53 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')]} 07:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:53 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:53 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 07:24:53 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 07:24:53 INFO - Using env: {'DISPLAY': ':0', 07:24:53 INFO - 'HOME': '/home/cltbld', 07:24:53 INFO - 'LANG': 'en_US.UTF-8', 07:24:53 INFO - 'LANGUAGE': 'en_US:en', 07:24:53 INFO - 'LOGNAME': 'cltbld', 07:24:53 INFO - 'MAIL': '/var/mail/cltbld', 07:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:53 INFO - 'MOZ_NO_REMOTE': '1', 07:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:53 INFO - 'NO_EM_RESTART': '1', 07:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:53 INFO - 'PWD': '/builds/slave/test', 07:24:53 INFO - 'SHELL': '/bin/bash', 07:24:53 INFO - 'SHLVL': '1', 07:24:53 INFO - 'TERM': 'linux', 07:24:53 INFO - 'TMOUT': '86400', 07:24:53 INFO - 'USER': 'cltbld', 07:24:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:53 INFO - '_': '/tools/buildbot/bin/python'} 07:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:53 INFO - Running setup.py (path:/tmp/pip-4fMlgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:53 INFO - Running setup.py (path:/tmp/pip-HWxC1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:54 INFO - Running setup.py (path:/tmp/pip-Rm11Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:54 INFO - Running setup.py (path:/tmp/pip-5TWl86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:54 INFO - Running setup.py (path:/tmp/pip-6LC2X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:54 INFO - Running setup.py (path:/tmp/pip-y9rDj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:54 INFO - Running setup.py (path:/tmp/pip-etb1Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:54 INFO - Running setup.py (path:/tmp/pip-H2sjW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:54 INFO - Running setup.py (path:/tmp/pip-Uq6gGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:54 INFO - Running setup.py (path:/tmp/pip-gr5tZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:54 INFO - Running setup.py (path:/tmp/pip-8p_jUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:54 INFO - Running setup.py (path:/tmp/pip-qyIV3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:54 INFO - Running setup.py (path:/tmp/pip-gHlouw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:54 INFO - Running setup.py (path:/tmp/pip-jZhdSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:54 INFO - Running setup.py (path:/tmp/pip-p032V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:54 INFO - Running setup.py (path:/tmp/pip-yQOO5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:55 INFO - Running setup.py (path:/tmp/pip-QmdlWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:24:55 INFO - Running setup.py install for manifestparser 07:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Running setup.py install for mozcrash 07:24:55 INFO - Running setup.py install for mozdebug 07:24:55 INFO - Running setup.py install for mozdevice 07:24:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Running setup.py install for mozfile 07:24:55 INFO - Running setup.py install for mozhttpd 07:24:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Running setup.py install for mozinfo 07:24:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Running setup.py install for mozInstall 07:24:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:24:55 INFO - Running setup.py install for mozleak 07:24:56 INFO - Running setup.py install for mozlog 07:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Running setup.py install for moznetwork 07:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Running setup.py install for mozprocess 07:24:56 INFO - Running setup.py install for mozprofile 07:24:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Running setup.py install for mozrunner 07:24:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Running setup.py install for mozscreenshot 07:24:56 INFO - Running setup.py install for moztest 07:24:56 INFO - Running setup.py install for mozversion 07:24:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:24:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:24:56 INFO - Cleaning up... 07:24:56 INFO - Return code: 0 07:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:56 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')]} 07:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:56 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')]} 07:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:56 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:24:56 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 07:24:56 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 07:24:56 INFO - Using env: {'DISPLAY': ':0', 07:24:56 INFO - 'HOME': '/home/cltbld', 07:24:56 INFO - 'LANG': 'en_US.UTF-8', 07:24:56 INFO - 'LANGUAGE': 'en_US:en', 07:24:56 INFO - 'LOGNAME': 'cltbld', 07:24:56 INFO - 'MAIL': '/var/mail/cltbld', 07:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:56 INFO - 'MOZ_NO_REMOTE': '1', 07:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:56 INFO - 'NO_EM_RESTART': '1', 07:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:56 INFO - 'PWD': '/builds/slave/test', 07:24:56 INFO - 'SHELL': '/bin/bash', 07:24:56 INFO - 'SHLVL': '1', 07:24:56 INFO - 'TERM': 'linux', 07:24:56 INFO - 'TMOUT': '86400', 07:24:56 INFO - 'USER': 'cltbld', 07:24:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:56 INFO - '_': '/tools/buildbot/bin/python'} 07:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:57 INFO - Running setup.py (path:/tmp/pip-WBELuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:57 INFO - Running setup.py (path:/tmp/pip-e6A_G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:57 INFO - Running setup.py (path:/tmp/pip-fmsYO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:57 INFO - Running setup.py (path:/tmp/pip-fpWcds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:57 INFO - Running setup.py (path:/tmp/pip-kvqWeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:57 INFO - Running setup.py (path:/tmp/pip-ll_4Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:57 INFO - Running setup.py (path:/tmp/pip-T1ekLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:57 INFO - Running setup.py (path:/tmp/pip-1rV5EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:57 INFO - Running setup.py (path:/tmp/pip-UPDH10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:57 INFO - Running setup.py (path:/tmp/pip-1_0Gam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:57 INFO - Running setup.py (path:/tmp/pip-PCP2xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:57 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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:57 INFO - Running setup.py (path:/tmp/pip-hvDnbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07: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)) 07:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:57 INFO - Running setup.py (path:/tmp/pip-wdh_t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:58 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)) 07:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:58 INFO - Running setup.py (path:/tmp/pip-b9quiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:58 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)) 07:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:58 INFO - Running setup.py (path:/tmp/pip-SN9kas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:58 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)) 07:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:58 INFO - Running setup.py (path:/tmp/pip-rFpUC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:58 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)) 07:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:58 INFO - Running setup.py (path:/tmp/pip-PzuUfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:58 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)) 07:24:58 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)) 07:24:58 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)) 07:24:58 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)) 07:24:58 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)) 07:24:58 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)) 07:24:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:24:58 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 07:25:00 INFO - Downloading blessings-1.6.tar.gz 07:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:00 INFO - Installing collected packages: blessings 07:25:00 INFO - Running setup.py install for blessings 07:25:00 INFO - Successfully installed blessings 07:25:00 INFO - Cleaning up... 07:25:00 INFO - Return code: 0 07:25:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:00 INFO - Reading from file tmpfile_stdout 07:25:00 INFO - Current package versions: 07:25:00 INFO - argparse == 1.2.1 07:25:00 INFO - blessings == 1.6 07:25:00 INFO - blobuploader == 1.2.4 07:25:00 INFO - docopt == 0.6.1 07:25:00 INFO - manifestparser == 1.1 07:25:00 INFO - mozInstall == 1.12 07:25:00 INFO - mozcrash == 0.17 07:25:00 INFO - mozdebug == 0.1 07:25:00 INFO - mozdevice == 0.48 07:25:00 INFO - mozfile == 1.2 07:25:00 INFO - mozhttpd == 0.7 07:25:00 INFO - mozinfo == 0.9 07:25:00 INFO - mozleak == 0.1 07:25:00 INFO - mozlog == 3.2 07:25:00 INFO - moznetwork == 0.27 07:25:00 INFO - mozprocess == 0.22 07:25:00 INFO - mozprofile == 0.28 07:25:00 INFO - mozrunner == 6.11 07:25:00 INFO - mozscreenshot == 0.1 07:25:00 INFO - mozsystemmonitor == 0.3 07:25:00 INFO - moztest == 0.7 07:25:00 INFO - mozversion == 1.4 07:25:00 INFO - psutil == 3.1.1 07:25:00 INFO - requests == 1.2.3 07:25:00 INFO - wsgiref == 0.1.2 07:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:00 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 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:25:00 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 07:25:00 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 07:25:00 INFO - Using env: {'DISPLAY': ':0', 07:25:00 INFO - 'HOME': '/home/cltbld', 07:25:00 INFO - 'LANG': 'en_US.UTF-8', 07:25:00 INFO - 'LANGUAGE': 'en_US:en', 07:25:00 INFO - 'LOGNAME': 'cltbld', 07:25:00 INFO - 'MAIL': '/var/mail/cltbld', 07:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:00 INFO - 'MOZ_NO_REMOTE': '1', 07:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:00 INFO - 'NO_EM_RESTART': '1', 07:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:00 INFO - 'PWD': '/builds/slave/test', 07:25:00 INFO - 'SHELL': '/bin/bash', 07:25:00 INFO - 'SHLVL': '1', 07:25:00 INFO - 'TERM': 'linux', 07:25:00 INFO - 'TMOUT': '86400', 07:25:00 INFO - 'USER': 'cltbld', 07:25:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:00 INFO - '_': '/tools/buildbot/bin/python'} 07:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 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)) 07:25:00 INFO - Cleaning up... 07:25:00 INFO - Return code: 0 07:25:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:25:00 INFO - Using env: {'DISPLAY': ':0', 07:25:00 INFO - 'HOME': '/home/cltbld', 07:25:00 INFO - 'LANG': 'en_US.UTF-8', 07:25:00 INFO - 'LANGUAGE': 'en_US:en', 07:25:00 INFO - 'LOGNAME': 'cltbld', 07:25:00 INFO - 'MAIL': '/var/mail/cltbld', 07:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:00 INFO - 'MOZ_NO_REMOTE': '1', 07:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:00 INFO - 'NO_EM_RESTART': '1', 07:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:00 INFO - 'PWD': '/builds/slave/test', 07:25:00 INFO - 'SHELL': '/bin/bash', 07:25:00 INFO - 'SHLVL': '1', 07:25:00 INFO - 'TERM': 'linux', 07:25:00 INFO - 'TMOUT': '86400', 07:25:00 INFO - 'USER': 'cltbld', 07:25:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:00 INFO - '_': '/tools/buildbot/bin/python'} 07:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:01 INFO - Downloading/unpacking jsonschema 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:01 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 07:25:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:03 INFO - Downloading/unpacking functools32 (from jsonschema) 07:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:03 INFO - warning: no files found matching '*.txt' 07:25:03 INFO - no previously-included directories found matching 'build' 07:25:03 INFO - no previously-included directories found matching 'dist' 07:25:03 INFO - no previously-included directories found matching '.git*' 07:25:03 INFO - Installing collected packages: jsonschema, functools32 07:25:03 INFO - Running setup.py install for functools32 07:25:03 INFO - warning: no files found matching '*.txt' 07:25:03 INFO - no previously-included directories found matching 'build' 07:25:03 INFO - no previously-included directories found matching 'dist' 07:25:03 INFO - no previously-included directories found matching '.git*' 07:25:03 INFO - Successfully installed jsonschema functools32 07:25:03 INFO - Cleaning up... 07:25:03 INFO - Return code: 0 07:25:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68f90caf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, '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': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', '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 07:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:25:03 INFO - Using env: {'DISPLAY': ':0', 07:25:03 INFO - 'HOME': '/home/cltbld', 07:25:03 INFO - 'LANG': 'en_US.UTF-8', 07:25:03 INFO - 'LANGUAGE': 'en_US:en', 07:25:03 INFO - 'LOGNAME': 'cltbld', 07:25:03 INFO - 'MAIL': '/var/mail/cltbld', 07:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:03 INFO - 'MOZ_NO_REMOTE': '1', 07:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:03 INFO - 'NO_EM_RESTART': '1', 07:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:03 INFO - 'PWD': '/builds/slave/test', 07:25:03 INFO - 'SHELL': '/bin/bash', 07:25:03 INFO - 'SHLVL': '1', 07:25:03 INFO - 'TERM': 'linux', 07:25:03 INFO - 'TMOUT': '86400', 07:25:03 INFO - 'USER': 'cltbld', 07:25:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:03 INFO - '_': '/tools/buildbot/bin/python'} 07:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:03 INFO - Downloading/unpacking flake8 07:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:25:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07: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 07: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 07: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 07: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 07: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 07: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 07:25:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:25:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07: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 07: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 07: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 07: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 07: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 07: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 07:25:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:25:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:06 INFO - no previously-included directories found matching 'docs/_build' 07:25:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:25:06 INFO - Running setup.py install for pep8 07:25:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:25:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:25:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:25:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:25:06 INFO - no previously-included directories found matching 'docs/_build' 07:25:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:25:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:25:06 INFO - Cleaning up... 07:25:06 INFO - Return code: 0 07:25:06 INFO - Running post-action listener: _resource_record_post_action 07:25:06 INFO - Running post-action listener: _start_resource_monitoring 07:25:06 INFO - Starting resource monitoring. 07:25:06 INFO - ##### 07:25:06 INFO - ##### Finished create-virtualenv step (success) 07:25:06 INFO - ##### 07:25:06 INFO - ##### 07:25:06 INFO - ##### Running install step. 07:25:06 INFO - ##### 07:25:06 INFO - Running pre-action listener: _resource_record_pre_action 07:25:06 INFO - Running main action method: install 07:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:06 INFO - Reading from file tmpfile_stdout 07:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:06 INFO - Reading from file tmpfile_stdout 07:25:06 INFO - Output received: 07:25:06 INFO - Usage: mozinstall [options] installer 07:25:06 INFO - Options: 07:25:06 INFO - -h, --help show this help message and exit 07:25:06 INFO - -d DEST, --destination=DEST 07:25:06 INFO - Directory to install application into. [default: 07:25:06 INFO - "/builds/slave/test"] 07:25:06 INFO - --app=APP Application being installed. [default: firefox] 07:25:06 INFO - mkdir: /builds/slave/test/build/application 07:25:06 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'] 07:25:06 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 07:25:22 INFO - Reading from file tmpfile_stdout 07:25:22 INFO - Output received: 07:25:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:25:22 INFO - Running post-action listener: _resource_record_post_action 07:25:22 INFO - ##### 07:25:22 INFO - ##### Finished install step (success) 07:25:22 INFO - ##### 07:25:22 INFO - ##### 07:25:22 INFO - ##### Running run-tests step. 07:25:22 INFO - ##### 07:25:22 INFO - Running pre-action listener: _resource_record_pre_action 07:25:22 INFO - Running main action method: run_tests 07:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:22 INFO - Python 2.7.3 07:25:22 INFO - Return code: 0 07:25:22 INFO - grabbing minidump binary from tooltool 07:25:22 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')]} 07:25:22 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 0x299f9c0>, '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 0x29a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:22 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 07:25:22 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 07:25:22 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 07:25:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:22 INFO - Return code: 0 07:25:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:25:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:25:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:25:23 INFO - Return code: 0 07:25:23 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 07:25:23 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 07:25:23 INFO - Using env: {'DISPLAY': ':0', 07:25:23 INFO - 'HOME': '/home/cltbld', 07:25:23 INFO - 'LANG': 'en_US.UTF-8', 07:25:23 INFO - 'LANGUAGE': 'en_US:en', 07:25:23 INFO - 'LOGNAME': 'cltbld', 07:25:23 INFO - 'MAIL': '/var/mail/cltbld', 07:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:23 INFO - 'MOZ_NO_REMOTE': '1', 07:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:23 INFO - 'NO_EM_RESTART': '1', 07:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:23 INFO - 'PWD': '/builds/slave/test', 07:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:23 INFO - 'SHELL': '/bin/bash', 07:25:23 INFO - 'SHLVL': '1', 07:25:23 INFO - 'TERM': 'linux', 07:25:23 INFO - 'TMOUT': '86400', 07:25:23 INFO - 'USER': 'cltbld', 07:25:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764', 07:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:23 INFO - '_': '/tools/buildbot/bin/python'} 07:25:23 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/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 07:25:24 INFO - mozversion application_buildid: 20160601060544 07:25:24 INFO - mozversion application_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 07:25:24 INFO - mozversion application_display_name: Nightly 07:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:24 INFO - mozversion application_name: Firefox 07:25:24 INFO - mozversion application_remotingname: firefox 07:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:25:24 INFO - mozversion application_vendor: Mozilla 07:25:24 INFO - mozversion application_version: 49.0a1 07:25:24 INFO - mozversion platform_buildid: 20160601060544 07:25:24 INFO - mozversion platform_changeset: 78e2125dfb6b02cdbab73a30c54bb4dc19aa310a 07:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:25:24 INFO - mozversion platform_version: 49.0a1 07:25:24 INFO - using testdate: 1464791124 07:25:24 INFO - actual date: 1464791124 07:25:24 INFO - starting webserver on 'localhost:33655' 07:25:24 INFO - SUITE-START | Running 2 tests 07:25:24 INFO - TEST-START | dromaeo_css 07:25:24 INFO - operating with platform_type : linux_ 07:25:24 INFO - Initialising browser for dromaeo_css test... 07:25:24 INFO - TEST-INFO | started process 6470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FT3eL/profile http://localhost:33655/getInfo.html) 07:25:28 INFO - PROCESS | 6470 | __metrics Screen width/height:1600/1200 07:25:28 INFO - PROCESS | 6470 | colorDepth:24 07:25:28 INFO - PROCESS | 6470 | Browser inner width/height: 1024/697 07:25:28 INFO - PROCESS | 6470 | __metrics 07:25:29 ERROR - PROCESS | 6470 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:25:30 INFO - TEST-INFO | 6470: exit 0 07:25:30 INFO - Browser initialized. 07:25:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:30 INFO - TEST-INFO | started process 6553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FT3eL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:42 INFO - PROCESS | 6553 | RSS: Main: 157655040 07:25:42 INFO - PROCESS | 6553 | 07:26:33 INFO - PROCESS | 6553 | 1464791193945 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] 07:28:45 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33655/tests/dromaeo/cssquery-ext.html) 07:28:46 INFO - PROCESS | 6553 | RSS: Main: 270770176 07:28:46 INFO - PROCESS | 6553 | 07:31:49 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-ext.html (next: http://localhost:33655/tests/dromaeo/cssquery-jquery.html) 07:31:50 INFO - PROCESS | 6553 | RSS: Main: 239276032 07:31:50 INFO - PROCESS | 6553 | 07:34:52 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33655/tests/dromaeo/cssquery-mootools.html) 07:34:52 INFO - PROCESS | 6553 | RSS: Main: 235802624 07:34:52 INFO - PROCESS | 6553 | 07:37:55 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33655/tests/dromaeo/cssquery-prototype.html) 07:37:55 INFO - PROCESS | 6553 | RSS: Main: 231694336 07:37:55 INFO - PROCESS | 6553 | 07:40:58 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33655/tests/dromaeo/cssquery-yui.html) 07:40:59 INFO - PROCESS | 6553 | RSS: Main: 218071040 07:40:59 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | Cycle 1(1): loaded http://localhost:33655/tests/dromaeo/cssquery-yui.html (next: http://localhost:33655/tests/dromaeo/cssquery-dojo.html) 07:44:02 INFO - PROCESS | 6553 | RSS: Main: 271765504 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | __start_tp_report 07:44:02 INFO - PROCESS | 6553 | _x_x_mozilla_page_load 07:44:02 INFO - PROCESS | 6553 | _x_x_mozilla_page_load_details 07:44:02 INFO - PROCESS | 6553 | |i|pagename|runs| 07:44:02 INFO - PROCESS | 6553 | |0;dojo.html;2662.853543055132;2679.95980060299;2698.9730102698973;2714.8371097734125;2724.673039235292;4630.166570017395;4698.436187657478;4707.223308154151;4756.334113224151;4795.712257264562;4692.554207350297;4708.340832283483;4712.693674911137;4724.527547245274;4743.8814029649275;4288.614024737765;4314.784260786963;4372.5627437256335;4398.626116780078;4475.328700694889;4405.933910991322;4425.601695847373;4426.933595996063;4478.328250762379;4492.730436173823;4233.957660423387;4284.228838809013;4305.806238719265;4321.9135617287475;4362.541933097043;4279.079997800488;4284.207421627009;4292.7424354538825;4375.868723938287;4408.911821763579;4284.871453856389;4289.957100429018;4322.070754787705;4329.9567004329865;4347.0653809430805;4503.437070366204;4568.2462393705;4589.2886602576655;4602.447706275235;4672.6261899047995;5047;5065.746712664389;5069.493050694901;5075.51782580658;5081.695098294077;5084.034033533617;5099.745012749348;5099.770510327045;5101.20931255656;5119.897602047939;4552.180607490617;4668.066386722669;4731.739754313546;4732.266498692708;4746.762661866893;5240.973795131076;5255.054090263713;5263.947360526346;5275.788968441219;5279.392869819943;5001.824936127218;5041.117804384291;5043.84868453947;5047.520485553867;5048.949510504848;4875.853724388274;4955.331030310862;5011.348524691767;5019.799208031711;5074.391073071181;4944.134776414185;4971.701697898137;4974.1543937530705;4978.054169707744;5031.874203144951;4956.083124621957;4961.454240033593;4969.3539839821315;4973.254011898244;5016.824411145592;4112.444819949328;4161.542230354658;4167.458230430086;4187.623113919762;4188.91622167561;3665.816709164531;3695.519582454264;3701.703863690952;3732.402815549499;3739.3456145174487;4221.409002739619;4225.471816022997;4227.239096962515;4263.4031235627035;4277.165952639206;4875.853724388274;4927.334809800703;4939.580135688435;5030.522100400456;5036.420811606712;4175.791210439526;4181.121964387452;4196.496420429568;4233.068724880522;4241.7879106044575;4489.932651010237;4495.730256184639;4504.909901801946;4508.977455112769;4549.909001820011;4654.185517534485;4741.620670346433;4744.620430365493;4765.976170119127;4794.976025119852;5080.669756465818;5086.796528138833;5096.694198348111;5097.184450488053;5152.76812543429;4793.760311984317;4809.711417314972;4812.35033270518;4821.590164835888;4854.247591623304;4831.661783675109;4891.364122664031;4939.901201976012;4948.727819969936;5069.366329208849;5005.899882002413;5023.120953833138;5026.246063090565;5027.145385284583;5080.161773307511;4870.586000190024;4872.4153101628035;4877.170880950318;4884.877878053077;4919.655624106278;4751.572358487752;4818.494058123846;4868.245421959602;4887.315775791321;4895.975520122377;4784.114938736345;4837.927431088466;4890.193118135468;4891.364122664173;4893.363862697969;4811.037792441596;4942.654014218971;4950.183219768698;4985.077760614298;4989.376327959005;4670.813167473263;4740.691855029412;4768.904621907612;4804.303376010529;4835.564799168092 07:44:02 INFO - PROCESS | 6553 | |1;ext.html;545.5754510462525;582.1616871704745;583.7927535724821;587.4037851580644;600.7566935391167;27465.17604471864;39358.60641393581;40269.19461610766;40669.59330406695;41177.79411102948;38640.42039369405;42772.78613606928;42812.78593607035;42885;42920.57079429205;7309.780706578785;7702.537847729126;7896.881546776803;7903.40724445666;9945.40327580344;9769.413835169913;10215.591376344937;10228.079472847443;10228.948855255714;10231.437270950095;10107.090361867431;10207.336523125972;10229.846552301722;10233.437160956144;10235.692929212135;10146.188304935624;10216.23378246627;10227.437490937995;10228.284020118595;10236.488175591265;10041.799164016678;10060.798784024279;10151.238657100674;10159.59361625534;10169.59321627134;39567.80216098901;40061.39907901384;40124.398134028015;40160.39759403611;40185;3239.8866039688733;3278.8360581970805;3297.1757060734817;3306.93386132276;3339.5825521809775;29940.850295748383;30342.54486182709;30389.24026899323;30537.38925221483;31047.223819404695;3359.428897087501;3377.5946886373545;3379.509971054208;3387.8983630491125;3405.557277553902;250395;251113;252068;252171;253220;54772.178417323776;55229;55247.342579722674;55322;55418.44581554214;58450;58480.12279815806;58649;58711.70644146752;59036.7048164765;14464.349104290332;14991;15035.323410446555;15040.924795375953;15047.172405517582;11265.15511336653;11470.59852905161;11471.885281147082;11472.082233421306;11478.311301321948;16353.264103115389;16715.331386744394;16887.831121688872;16889.662206755795;16903.32386704518;5721.885562288731;5866.472017518444;5868.94131058684;5932.6058376281535;5947.375525569752;801.7354273089867;853.4964371021127;869.8477766390856;894.1237587164616;901.3375169250595;26654.46691066168;28183.43633127367;28237.29406764806;28622.85688571544;28700.569491457645;861.4700569681797;929.0384452092052;997.7378616050702;1038.2161468091542;1054.4569546683465;14925.626859328604;15255.771163432557;15317.31072101758;15390.615234619225;15440.472390679895;381798;382535;383807;383831;384100;50252;50987;51370.74314628403;51385;51607.48392516102;1094.5074716377662;1157.5080590748898;1192.2250537150921;1219.5609580550995;1249.1505776072358;26110.34724131912;29360.41279174447;30001.849990749906;30281;30435;42538.57461425346;42844;42983.570164297955;43083.569164307955;43097.569024309356;247407;247568;248130;248858;249071;22498.325050248517;24222.63666045046;25219.117330893332;25409.87295063513;26517.60223596686;42679.57320426756;43525.56474435342;43646.56353436425;44253.55746442494;44844.775776120914;37072.25855482929;37173.070673233386;37232.25535489221;37679;37936;36982.26035479221;37234.813825930694;37767;37924;37926.810365948;35733.64266357303;36042.27915441729;36438.453423198145;36856.26287474182;36866;32077.518837217925;33612.831935840164;33773;33992.66007339994;34036.14909627279;25421.745782541937;25488;25769.484610307314;25775.742242578086;26234.21297361082 07:44:02 INFO - PROCESS | 6553 | |2;jquery.html;369.95375578052744;376.75134411288536;380.75060835152976;394.06213212554115;394.48125714685204;15696.372145114196;16057.357705691773;16737.16314184292;16764.32942682293;16770.245338959747;11039.779204415907;11042.779144417127;11046.116310695144;11047.337159770399;11251.268667536604;4540.2054640437955;4610.838620648278;4618.261078227484;4666.789994450241;4671;4671.112488627167;4716.599089077416;4755.381800365947;4761.714297142165;4777.020710754305;4733.313669517918;4780.115678599453;4780.282957556359;4780.856574302759;4821.204501257306;4647.395838540985;4760.976195119037;4772.73749943753;4781.593564547018;4823.855284341475;4404.559544045602;4651.2557990721325;4652.371929789469;4654.045920586272;4657.998530315998;11191.384473853936;12354;12395.876041239653;12483.438245278985;12485;1805.0523475175507;1890.4801179675699;1902.6194761047846;1904.3430016644375;2016.8184863362367;8942.508162051085;9005.594748236344;9165.083491650781;9286.674966376144;9373.671921482715;1538.9384424623001;1539.5227479481396;1607.3249235321193;1630.812456567498;1638.6313079557124;67462.66268668625;68325;68363.31636683669;68468.6576567114;68481;10013.39919604826;10083;10100.292979491513;10170.338927969806;10275.434851083262;13999.580012599637;14024.649383765283;14029.85970140306;14080.22558759278;14123.034162825921;7074.327938845904;7185.497015208885;7186.461015423864;7248.9275107249305;7255;6672.165979252593;6715.899261511081;6759.763408280785;6808.08090907731;6863.485238607124;4296.935545966813;4316.597105940582;4353.782310884507;4376.890577735582;4386.824527018947;1858.27527264367;1879.9624007519774;1894.2896413844808;1899.3067530351323;1912.244663357966;816.603947085663;865.2947847504264;920.2132176988712;951.9286053546011;953.5041778275397;16280.10459424743;16297.592560185853;16432.096234706965;16591.41930032443;16822.990620562807;860.63627730294;882.1443200095897;891.913977637369;936.017181958954;941.9340646154841;9115.635374585076;9402.01278865723;9454.95272523633;9469.289803264783;9641.951790241144;354718;371857;373117;373159;379427;56628.716856415456;70945;76162.61918690371;76461.23538764541;79108.60445697735;872.4983134697447;878.6473794466046;880.0539420123393;906.3112034853427;909.4770506958525;11560.537578497102;14317.713645727235;14797.778033329723;15260;15283.847161528241;31501.369972600878;32506.512402314456;32523.186920326236;35350.82324588361;35968;43620.56379436165;45140.32289515725;45326.32010519779;51183.232251517;51929;7190.6404679764755;7428.554286742813;7444.292792184734;7533.434992375484;7561.054868141482;10298.948505257425;10812.56749730002;10820.891791082304;10859.131269498579;10904.127669786556;8764.517951512727;9201.171894529256;9523.619055237712;9634.90365096368;9663.46850923206;9315.6273749052;9523.61905523799;9734.659286924923;9933.801323973335;9991.350562213433;6429.839254018687;9482.525873706149;9527.142557169887;9798.75503112428;9842.311038227543;7339;7388.4828062037295;7474.514156579805;7520.097588289222;7551.73568925085;8267.379946504156;8893.377463577488;9079.727608171765;9082.364234503786;9230.35387522867 07:44:02 INFO - PROCESS | 6553 | |3;mootools.html;1198.838156848825;1388.6736616895032;1395.602253357793;1503.9774403383951;1719.9140042997856;6785.084013658155;7541.924580754191;7621.58081305528;7700.807479813;8001.3998950078685;7650.311471967521;7839.333656639193;7852.175521570239;7852.764417067498;7860.292573668368;2128.3189379398636;2153.493928926701;2156.924507642233;2158.7841215878443;2159.125554150564;2099.4226587688354;2122.3632910126976;2203;2204.6252137136726;2208.7570367259586;2110.7889211078846;2150.5591353772516;2151.591197672445;2157.072458842697;2159.492519257973;2125.4898824282136;2130.211821625993;2134.157007981846;2134.178341338588;2136.2309568555306;2085.4682056075753;2159.0176469706403;2161.978380216209;2162.7837216278404;2166.880821554814;7608.695652173907;7779.144294127642;7825.530468171871;7865.724699635485;7868.72459463916;4460.866174014753;4638.721676699409;4639.559241872017;4640.211164102111;4642.14120387726;2661.5342315094977;2772.4039331543813;2817.0281252967693;2824.166870773127;2829.0381270368175;855;868.9956550217208;874.9475031498131;883.3110174064241;898.7079199260266;10429.113525350354;10699.144068474503;10737.355758654428;10744;10747.785044299148;4149.771762553029;4228.640565551963;4295.806688699016;4300.440942677432;4302.526722060571;9230.53847307632;9256.16694497485;9267.953660231655;9298.163165315154;9313.39462934907;4565.6119229865835;4643.767811609406;4645.140648979949;4646.210144275481;4651.5813576778255;3713.8700145494777;4089;4232.830686772556;4242.384854196124;4293.291606884829;3680.7791532508136;3764.9435258471144;3801.353769859131;3831.750936189139;3847.8460861565222;1194.713268815478;1211.357980270458;1220.5483970930634;1221.6090850927797;1227.8342423772676;796.223681910133;799.3165843204093;826.2398593294183;840.7940054686519;928.2295694573488;5319.1223448131395;5604.8038318658655;5616.297962754656;5709.115087161496;5721.199032135504;382.8793929912069;383.2813474734872;384.9210911763138;387.9379299312153;397.8408636545405;3822.866199682998;3909.4331321958157;3917.5494818095713;3943.9014024649614;3962.9405558916637;9423;9679.177269931994;9831.557579908922;9838.852417213748;9843.803123937481;9592.232621390272;9706.90293097074;9717.6598819041;9732;9748.122668959828;7194.604296763729;7446.441516886255;7448.4041276697735;7462.44031697614;7463.738769143162;5414.160805075219;5485.670859748428;5583.2462617547735;5643.943560564506;5669.036263835075;8637.754183912102;8789.91210087891;9051.864222036806;9055.320850936074;9068.22920051803;8989.538338618053;9156.130167634064;9176.128267814547;9194.218491428035;9247.306452015991;6267.655278959519;6455.838604034749;6464.773732919325;6987.475939304471;7063.117110361205;6791.524593278423;7603.771886843404;7604.771856844303;7787.844243114992;7797.454178207471;6596.769113081019;6790.219124800711;6871.896921546281;6906.205786334636;6923.653817309215;6830.31696830313;6852.451803855779;6901.137357830271;6903.93096069053;6922.169339679271;6480.805575832733;6546.312637173219;6549.901751473827;6552.312007239171;6688.565243259172;4897.730624815669;4915.139850526072;4994.9500504994485;4999.500049994971;5018.4730603286125;4989.501049894981;4998.1253280676465;4999.600031997359;5053.59571234293;5136.640435169502 07:44:02 INFO - PROCESS | 6553 | |4;prototype.html;304.78664934545816;309.1344236138811;310.04815217282936;311.4782738912322;312.87954137656993;4911.2633105034265;4959.553640172384;4963.751812409383;4968.130577149002;4976.377952755905;4867.780949857256;4890.266460030997;4892.828750993716;4903.754812259391;4909.214525675892;3658.9817050914776;3761.887143385703;3780.092777733352;3838.193979264358;3870.0518372998654;3819.8281077351585;3845.4039623858207;3849.480320156771;3868.5686296070494;3870.903227419323;3676.1728611062563;3858.5562660294145;3860.073582340232;3869.419587061949;3873.845046198149;3661.5789184243754;3793.9810300948457;3800.1259710266795;3828.9808550957346;3868.2650296443867;3365.6129545102135;3367.3770352484626;3374.645662205482;3397.6432474590306;3398.2863598644312;4652.185867473178;4653.232216684277;4662.277347011219;4673.719576825401;4723.504032076651;4268.146370725836;4372.27857403528;4374.58441448062;4410.412251589425;4412.713173643703;5015.4733752956145;5096.719680417613;5141.074606570815;5141.794328226866;5143.922841157386;3689.1330537323706;3695.796731179784;3702.851885924587;3712.7215458840697;3727.552693676776;5267.920981185285;5300.946990530084;5336.199570064483;5382.381026181961;5410.864728381783;3755.6807671347697;3763.1909139535132;3783.697304215656;3784.375578029649;3797.9620203798163;3839.8080095995088;3848.634379733921;3854.2676891390547;3856.82644281008;3858.9421158682644;4341.7829108545075;4342;4360.49854266757;4381.751200907726;4390.407295015132;4930.309756634074;5064.696118232918;5071.46749591295;5099.974500127476;5105.723569107723;1291.8320618319747;1322.3983087695076;1327.143992125074;1331.7602831490424;1334.5996201139812;850.6002178975872;870.3298460185622;891.8751374807532;892.7723430525305;894.3158483759929;4247.49030116388;4265.1043280910735;4372.497162826316;4377.759223242752;4409.691321607456;5207.973960130175;5213.679912438928;5217.843464696065;5218.869528261824;5227.797606550439;4211.894702632398;4398.978005109954;4404.823807047682;4409.382686423904;4420.58004489573;2788.3029242689327;2799.1042866283;2799.2721892308145;2806.5228911085164;2822.618946442245;4983.27742477346;4986.750662466862;4994.2508623706735;5001.249812528077;5001.799928002839;5132.820351287762;5377.462253774669;5414.160805075219;5431.755570999315;5473;4898;4926.088673595468;4947;5042.394912610437;5056.6713163644245;5212.748940254388;5240.135377662643;5257.947420525746;5285.867853303698;5291.629585928948;5080.282049103712;5233.241180028798;5250.921236181537;5252.763625636932;5252.789888404421;4928.14167782678;4962.42932062803;4966.652334336562;5024.4473107957365;5026.84919452417;3728.161163738137;3730.403135498307;3745.812709364466;3764.7199952016445;3806.695464362789;5145.459726728789;5199.399233231846;5267.446918073547;5269.631125821155;5337.572994160536;5064.924026139537;5066.898662026665;5067.41724701664;5112.233165025276;5136.30659860914;5134.358205224347;5136.871578210575;5145.009340939283;5151.278820965143;5175.094358487175;4833.830815921426;4913.336699545515;5077.796888124433;5158.767855446589;5168.276441298146;5005.623453550303;5157;5165.457626949266;5179.274901513866;5195.6622819516615;5021.1464051112125;5068.6451948363265;5070.746462676925;5081.8729531762;5093.337866077386 07:44:02 INFO - PROCESS | 6553 | |5;yui.html;621.3879328861074;636.1729751323279;671.506442764568;683.9452843772499;723.0780754537964;11749.588764393247;12396.690082747913;12404.31776252307;12430.627081187557;12434.875651243485;11840.993515551188;12282.508699652026;12296.07779416545;12316.938415307934;12355.444005019774;783.6121120045557;791.1811275330034;798.5288679678988;800.9919900800976;801.7995501124719;777.4985134588187;781.2421950707804;787.016229712859;787.6691789448416;789.4513313247295;836.1680128272377;836.9874451883227;838.0153319849184;838.1409055717908;838.4801423117675;833.2625626320689;835.2065537739142;835.5112259328331;835.7534527314426;835.8579041562949;607.1803065861052;610.4963405190691;610.5725991805709;610.5848023344124;610.8656095658948;11134.665960021212;11142.944285278521;11181.72045698856;11195.832062519068;11207.327560346404;10208.183345332356;10335.22485813567;10437.895621043768;10458.267921245515;10462;8868;8965.372423930328;9112.134347237068;9203.987561368243;9326.766830829283;3197.696218859228;3297;3301.339732053575;3361.3949489091956;3389.305192435545;35955.460668089996;39711.8014409929;42203.57796422027;42413.787931060455;44680.55319446797;10292.485375731334;10414.271001030007;10424.68725938223;10557.313774604627;10646.89353106459;17678.29286828538;17697.823021769877;17805.376811811526;17831.73252401215;17849;6986.476014298948;7069.646517674096;7074.111151859969;7125.608091555015;7283.089613798275;3768.340540405418;3793.0327766419387;3794.2356804086235;3803.505544279226;3807.352750032446;2853.885844566194;2940.088572542476;2943.058221369184;2946.1897978056204;2947.469455497988;506.39485814451376;516.068496364059;520.885405210853;522.0602914753505;523.1107117899586;494.178950567154;589.3634874335708;601.0413390641919;614.2782230878789;641.0992555459587;8334.208250216341;8337.833243335099;8358.498490090615;8468.364872634455;8544.40189186751;499.37827404881153;541.8564080518665;574.643720893049;613.929398119213;631.6967855429419;3920.353141731582;3953.802309884494;3961.3661814110183;4039.2527382434346;4042.292598795199;47799.76100119477;49668.50331496711;49749;54541.454585454434;55032.449675503536;47935.76032119817;48549;48927.510724892294;49910.50089499131;49920.50079499231;45228.547714522436;45239.321410178876;45622.771886140355;45698.543014569426;46706.299405508944;8310.916890831015;8438.240558349778;8541.914580854113;8560.101189375026;8656.697015604424;30636.693633064275;31754.206144846565;32129.67870321267;32230.516542252353;32473.188170295933;40011.79994100011;40094.599054009086;40419.595804041586;40452.39321410123;40884;10102.646407375707;10203.183745300506;10262.794744104927;10403.271770975958;10505.107065899485;11288.830667539829;11572.305661660328;11677.299362038304;12244.142909996215;12260.448279827251;11073.833892491459;11747.706307342385;11775.705607359885;11808.11439142085;11827.349495777815;11031.22781405294;11182.440877956233;11451.370174640475;11744.236624619372;11757.76484470323;11252.099832013582;11281.09751219884;11576.479058442223;11596.188266821242;11628.825567616323;9570.554600343732;9691.370060946016;9777.41335519871;9861.506924653595;9862.950685246527;8055.476394034369;8295.170482951657;9274.6290148396;9591.568379423083;9775.85336219943 07:44:02 INFO - PROCESS | 6553 | __end_tp_report 07:44:02 INFO - PROCESS | 6553 | __start_cc_report 07:44:02 INFO - PROCESS | 6553 | _x_x_mozilla_cycle_collect,1013 07:44:02 INFO - PROCESS | 6553 | __end_cc_report 07:44:02 INFO - PROCESS | 6553 | __startTimestamp1464792242478__endTimestamp 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | ------- Summary: start ------- 07:44:02 INFO - PROCESS | 6553 | Number of tests: 6 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#0] dojo.html Cycles:165 Average:4645.00 Median:4784.11 stddev:490.33 (10.2%) stddev-sans-first:466.53 07:44:02 INFO - PROCESS | 6553 | Values: 2662.9 2680.0 2699.0 2714.8 2724.7 4630.2 4698.4 4707.2 4756.3 4795.7 4692.6 4708.3 4712.7 4724.5 4743.9 4288.6 4314.8 4372.6 4398.6 4475.3 4405.9 4425.6 4426.9 4478.3 4492.7 4234.0 4284.2 4305.8 4321.9 4362.5 4279.1 4284.2 4292.7 4375.9 4408.9 4284.9 4290.0 4322.1 4330.0 4347.1 4503.4 4568.2 4589.3 4602.4 4672.6 5047.0 5065.7 5069.5 5075.5 5081.7 5084.0 5099.7 5099.8 5101.2 5119.9 4552.2 4668.1 4731.7 4732.3 4746.8 5241.0 5255.1 5263.9 5275.8 5279.4 5001.8 5041.1 5043.8 5047.5 5048.9 4875.9 4955.3 5011.3 5019.8 5074.4 4944.1 4971.7 4974.2 4978.1 5031.9 4956.1 4961.5 4969.4 4973.3 5016.8 4112.4 4161.5 4167.5 4187.6 4188.9 3665.8 3695.5 3701.7 3732.4 3739.3 4221.4 4225.5 4227.2 4263.4 4277.2 4875.9 4927.3 4939.6 5030.5 5036.4 4175.8 4181.1 4196.5 4233.1 4241.8 4489.9 4495.7 4504.9 4509.0 4549.9 4654.2 4741.6 4744.6 4766.0 4795.0 5080.7 5086.8 5096.7 5097.2 5152.8 4793.8 4809.7 4812.4 4821.6 4854.2 4831.7 4891.4 4939.9 4948.7 5069.4 5005.9 5023.1 5026.2 5027.1 5080.2 4870.6 4872.4 4877.2 4884.9 4919.7 4751.6 4818.5 4868.2 4887.3 4896.0 4784.1 4837.9 4890.2 4891.4 4893.4 4811.0 4942.7 4950.2 4985.1 4989.4 4670.8 4740.7 4768.9 4804.3 4835.6 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#1] ext.html Cycles:180 Average:46144.10 Median:18575.30 stddev:78997.12 (425.3%) stddev-sans-first:79144.54 07:44:02 INFO - PROCESS | 6553 | Values: 545.6 582.2 583.8 587.4 600.8 27465.2 39358.6 40269.2 40669.6 41177.8 38640.4 42772.8 42812.8 42885.0 42920.6 7309.8 7702.5 7896.9 7903.4 9945.4 9769.4 10215.6 10228.1 10228.9 10231.4 10107.1 10207.3 10229.8 10233.4 10235.7 10146.2 10216.2 10227.4 10228.3 10236.5 10041.8 10060.8 10151.2 10159.6 10169.6 39567.8 40061.4 40124.4 40160.4 40185.0 3239.9 3278.8 3297.2 3306.9 3339.6 29940.9 30342.5 30389.2 30537.4 31047.2 3359.4 3377.6 3379.5 3387.9 3405.6 250395.0 251113.0 252068.0 252171.0 253220.0 54772.2 55229.0 55247.3 55322.0 55418.4 58450.0 58480.1 58649.0 58711.7 59036.7 14464.3 14991.0 15035.3 15040.9 15047.2 11265.2 11470.6 11471.9 11472.1 11478.3 16353.3 16715.3 16887.8 16889.7 16903.3 5721.9 5866.5 5868.9 5932.6 5947.4 801.7 853.5 869.8 894.1 901.3 26654.5 28183.4 28237.3 28622.9 28700.6 861.5 929.0 997.7 1038.2 1054.5 14925.6 15255.8 15317.3 15390.6 15440.5 381798.0 382535.0 383807.0 383831.0 384100.0 50252.0 50987.0 51370.7 51385.0 51607.5 1094.5 1157.5 1192.2 1219.6 1249.2 26110.3 29360.4 30001.8 30281.0 30435.0 42538.6 42844.0 42983.6 43083.6 43097.6 247407.0 247568.0 248130.0 248858.0 249071.0 22498.3 24222.6 25219.1 25409.9 26517.6 42679.6 43525.6 43646.6 44253.6 44844.8 37072.3 37173.1 37232.3 37679.0 37936.0 36982.3 37234.8 37767.0 37924.0 37926.8 35733.6 36042.3 36438.5 36856.3 36866.0 32077.5 33612.8 33773.0 33992.7 34036.1 25421.7 25488.0 25769.5 25775.7 26234.2 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#2] jquery.html Cycles:180 Average:22710.22 Median:4724.96 stddev:61251.90 (1296.3%) stddev-sans-first:61400.76 07:44:02 INFO - PROCESS | 6553 | Values: 370.0 376.8 380.8 394.1 394.5 15696.4 16057.4 16737.2 16764.3 16770.2 11039.8 11042.8 11046.1 11047.3 11251.3 4540.2 4610.8 4618.3 4666.8 4671.0 4671.1 4716.6 4755.4 4761.7 4777.0 4733.3 4780.1 4780.3 4780.9 4821.2 4647.4 4761.0 4772.7 4781.6 4823.9 4404.6 4651.3 4652.4 4654.0 4658.0 11191.4 12354.0 12395.9 12483.4 12485.0 1805.1 1890.5 1902.6 1904.3 2016.8 8942.5 9005.6 9165.1 9286.7 9373.7 1538.9 1539.5 1607.3 1630.8 1638.6 67462.7 68325.0 68363.3 68468.7 68481.0 10013.4 10083.0 10100.3 10170.3 10275.4 13999.6 14024.6 14029.9 14080.2 14123.0 7074.3 7185.5 7186.5 7248.9 7255.0 6672.2 6715.9 6759.8 6808.1 6863.5 4296.9 4316.6 4353.8 4376.9 4386.8 1858.3 1880.0 1894.3 1899.3 1912.2 816.6 865.3 920.2 951.9 953.5 16280.1 16297.6 16432.1 16591.4 16823.0 860.6 882.1 891.9 936.0 941.9 9115.6 9402.0 9455.0 9469.3 9642.0 354718.0 371857.0 373117.0 373159.0 379427.0 56628.7 70945.0 76162.6 76461.2 79108.6 872.5 878.6 880.1 906.3 909.5 11560.5 14317.7 14797.8 15260.0 15283.8 31501.4 32506.5 32523.2 35350.8 35968.0 43620.6 45140.3 45326.3 51183.2 51929.0 7190.6 7428.6 7444.3 7533.4 7561.1 10298.9 10812.6 10820.9 10859.1 10904.1 8764.5 9201.2 9523.6 9634.9 9663.5 9315.6 9523.6 9734.7 9933.8 9991.4 6429.8 9482.5 9527.1 9798.8 9842.3 7339.0 7388.5 7474.5 7520.1 7551.7 8267.4 8893.4 9079.7 9082.4 9230.4 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#3] mootools.html Cycles:180 Average:5198.36 Median:5366.64 stddev:2923.67 (54.5%) stddev-sans-first:2916.42 07:44:02 INFO - PROCESS | 6553 | Values: 1198.8 1388.7 1395.6 1504.0 1719.9 6785.1 7541.9 7621.6 7700.8 8001.4 7650.3 7839.3 7852.2 7852.8 7860.3 2128.3 2153.5 2156.9 2158.8 2159.1 2099.4 2122.4 2203.0 2204.6 2208.8 2110.8 2150.6 2151.6 2157.1 2159.5 2125.5 2130.2 2134.2 2134.2 2136.2 2085.5 2159.0 2162.0 2162.8 2166.9 7608.7 7779.1 7825.5 7865.7 7868.7 4460.9 4638.7 4639.6 4640.2 4642.1 2661.5 2772.4 2817.0 2824.2 2829.0 855.0 869.0 874.9 883.3 898.7 10429.1 10699.1 10737.4 10744.0 10747.8 4149.8 4228.6 4295.8 4300.4 4302.5 9230.5 9256.2 9268.0 9298.2 9313.4 4565.6 4643.8 4645.1 4646.2 4651.6 3713.9 4089.0 4232.8 4242.4 4293.3 3680.8 3764.9 3801.4 3831.8 3847.8 1194.7 1211.4 1220.5 1221.6 1227.8 796.2 799.3 826.2 840.8 928.2 5319.1 5604.8 5616.3 5709.1 5721.2 382.9 383.3 384.9 387.9 397.8 3822.9 3909.4 3917.5 3943.9 3962.9 9423.0 9679.2 9831.6 9838.9 9843.8 9592.2 9706.9 9717.7 9732.0 9748.1 7194.6 7446.4 7448.4 7462.4 7463.7 5414.2 5485.7 5583.2 5643.9 5669.0 8637.8 8789.9 9051.9 9055.3 9068.2 8989.5 9156.1 9176.1 9194.2 9247.3 6267.7 6455.8 6464.8 6987.5 7063.1 6791.5 7603.8 7604.8 7787.8 7797.5 6596.8 6790.2 6871.9 6906.2 6923.7 6830.3 6852.5 6901.1 6903.9 6922.2 6480.8 6546.3 6549.9 6552.3 6688.6 4897.7 4915.1 4995.0 4999.5 5018.5 4989.5 4998.1 4999.6 5053.6 5136.6 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#4] prototype.html Cycles:180 Average:4256.04 Median:4906.48 stddev:1229.43 (25.1%) stddev-sans-first:1196.57 07:44:02 INFO - PROCESS | 6553 | Values: 304.8 309.1 310.0 311.5 312.9 4911.3 4959.6 4963.8 4968.1 4976.4 4867.8 4890.3 4892.8 4903.8 4909.2 3659.0 3761.9 3780.1 3838.2 3870.1 3819.8 3845.4 3849.5 3868.6 3870.9 3676.2 3858.6 3860.1 3869.4 3873.8 3661.6 3794.0 3800.1 3829.0 3868.3 3365.6 3367.4 3374.6 3397.6 3398.3 4652.2 4653.2 4662.3 4673.7 4723.5 4268.1 4372.3 4374.6 4410.4 4412.7 5015.5 5096.7 5141.1 5141.8 5143.9 3689.1 3695.8 3702.9 3712.7 3727.6 5267.9 5300.9 5336.2 5382.4 5410.9 3755.7 3763.2 3783.7 3784.4 3798.0 3839.8 3848.6 3854.3 3856.8 3858.9 4341.8 4342.0 4360.5 4381.8 4390.4 4930.3 5064.7 5071.5 5100.0 5105.7 1291.8 1322.4 1327.1 1331.8 1334.6 850.6 870.3 891.9 892.8 894.3 4247.5 4265.1 4372.5 4377.8 4409.7 5208.0 5213.7 5217.8 5218.9 5227.8 4211.9 4399.0 4404.8 4409.4 4420.6 2788.3 2799.1 2799.3 2806.5 2822.6 4983.3 4986.8 4994.3 5001.2 5001.8 5132.8 5377.5 5414.2 5431.8 5473.0 4898.0 4926.1 4947.0 5042.4 5056.7 5212.7 5240.1 5257.9 5285.9 5291.6 5080.3 5233.2 5250.9 5252.8 5252.8 4928.1 4962.4 4966.7 5024.4 5026.8 3728.2 3730.4 3745.8 3764.7 3806.7 5145.5 5199.4 5267.4 5269.6 5337.6 5064.9 5066.9 5067.4 5112.2 5136.3 5134.4 5136.9 5145.0 5151.3 5175.1 4833.8 4913.3 5077.8 5158.8 5168.3 5005.6 5157.0 5165.5 5179.3 5195.7 5021.1 5068.6 5070.7 5081.9 5093.3 07:44:02 INFO - PROCESS | 6553 | 07:44:02 INFO - PROCESS | 6553 | [#5] yui.html Cycles:180 Average:12842.93 Median:45233.93 stddev:14614.24 (32.3%) stddev-sans-first:14626.42 07:44:02 INFO - PROCESS | 6553 | Values: 621.4 636.2 671.5 683.9 723.1 11749.6 12396.7 12404.3 12430.6 12434.9 11841.0 12282.5 12296.1 12316.9 12355.4 783.6 791.2 798.5 801.0 801.8 777.5 781.2 787.0 787.7 789.5 836.2 837.0 838.0 838.1 838.5 833.3 835.2 835.5 835.8 835.9 607.2 610.5 610.6 610.6 610.9 11134.7 11142.9 11181.7 11195.8 11207.3 10208.2 10335.2 10437.9 10458.3 10462.0 8868.0 8965.4 9112.1 9204.0 9326.8 3197.7 3297.0 3301.3 3361.4 3389.3 35955.5 39711.8 42203.6 42413.8 44680.6 10292.5 10414.3 10424.7 10557.3 10646.9 17678.3 17697.8 17805.4 17831.7 17849.0 6986.5 7069.6 7074.1 7125.6 7283.1 3768.3 3793.0 3794.2 3803.5 3807.4 2853.9 2940.1 2943.1 2946.2 2947.5 506.4 516.1 520.9 522.1 523.1 494.2 589.4 601.0 614.3 641.1 8334.2 8337.8 8358.5 8468.4 8544.4 499.4 541.9 574.6 613.9 631.7 3920.4 3953.8 3961.4 4039.3 4042.3 47799.8 49668.5 49749.0 54541.5 55032.4 47935.8 48549.0 48927.5 49910.5 49920.5 45228.5 45239.3 45622.8 45698.5 46706.3 8310.9 8438.2 8541.9 8560.1 8656.7 30636.7 31754.2 32129.7 32230.5 32473.2 40011.8 40094.6 40419.6 40452.4 40884.0 10102.6 10203.2 10262.8 10403.3 10505.1 11288.8 11572.3 11677.3 12244.1 12260.4 11073.8 11747.7 11775.7 11808.1 11827.3 11031.2 11182.4 11451.4 11744.2 11757.8 11252.1 11281.1 11576.5 11596.2 11628.8 9570.6 9691.4 9777.4 9861.5 9863.0 8055.5 8295.2 9274.6 9591.6 9775.9 07:44:02 INFO - PROCESS | 6553 | -------- Summary: end -------- 07:44:02 INFO - PROCESS | 6553 | 07:44:03 INFO - TEST-INFO | 6553: exit 0 07:44:03 INFO - TEST-OK | dromaeo_css | took 1119194ms 07:44:03 INFO - TEST-START | kraken 07:44:03 INFO - operating with platform_type : linux_ 07:44:03 INFO - Initialising browser for kraken test... 07:44:03 INFO - TEST-INFO | started process 6736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GkICJ/profile http://localhost:33655/getInfo.html) 07:44:07 INFO - PROCESS | 6736 | __metrics Screen width/height:1600/1200 07:44:07 INFO - PROCESS | 6736 | colorDepth:24 07:44:07 INFO - PROCESS | 6736 | Browser inner width/height: 1024/697 07:44:07 INFO - PROCESS | 6736 | __metrics 07:44:08 ERROR - PROCESS | 6736 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:44:09 INFO - TEST-INFO | 6736: exit 0 07:44:09 INFO - Browser initialized. 07:44:09 INFO - Running cycle 1/1 for kraken test... 07:44:09 INFO - TEST-INFO | started process 6820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7GkICJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:21 INFO - PROCESS | 6820 | RSS: Main: 157474816 07:44:21 INFO - PROCESS | 6820 | 07:44:24 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33655/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:25 INFO - PROCESS | 6820 | RSS: Main: 215228416 07:44:25 INFO - PROCESS | 6820 | 07:44:27 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33655/tests/kraken/driver.html?testName=audio-dft) 07:44:28 INFO - PROCESS | 6820 | RSS: Main: 202637312 07:44:28 INFO - PROCESS | 6820 | 07:44:31 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33655/tests/kraken/driver.html?testName=audio-fft) 07:44:32 INFO - PROCESS | 6820 | RSS: Main: 269996032 07:44:32 INFO - PROCESS | 6820 | 07:44:34 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33655/tests/kraken/driver.html?testName=audio-oscillator) 07:44:35 INFO - PROCESS | 6820 | RSS: Main: 180969472 07:44:35 INFO - PROCESS | 6820 | 07:44:37 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:38 INFO - PROCESS | 6820 | RSS: Main: 184029184 07:44:38 INFO - PROCESS | 6820 | 07:44:41 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33655/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:41 INFO - PROCESS | 6820 | RSS: Main: 220332032 07:44:41 INFO - PROCESS | 6820 | 07:44:45 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33655/tests/kraken/driver.html?testName=imaging-desaturate) 07:44:45 INFO - PROCESS | 6820 | RSS: Main: 216682496 07:44:45 INFO - PROCESS | 6820 | 07:44:48 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33655/tests/kraken/driver.html?testName=json-parse-financial) 07:44:49 INFO - PROCESS | 6820 | RSS: Main: 219078656 07:44:49 INFO - PROCESS | 6820 | 07:44:51 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:44:51 INFO - PROCESS | 6820 | RSS: Main: 208519168 07:44:51 INFO - PROCESS | 6820 | 07:44:53 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:44:54 INFO - PROCESS | 6820 | RSS: Main: 210276352 07:44:54 INFO - PROCESS | 6820 | 07:44:56 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:44:57 INFO - PROCESS | 6820 | RSS: Main: 216465408 07:44:57 INFO - PROCESS | 6820 | 07:44:59 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:00 INFO - PROCESS | 6820 | RSS: Main: 221802496 07:45:00 INFO - PROCESS | 6820 | 07:45:03 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:04 INFO - PROCESS | 6820 | RSS: Main: 222826496 07:45:04 INFO - PROCESS | 6820 | 07:45:05 INFO - PROCESS | 6820 | Cycle 1(1): loaded http://localhost:33655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33655/tests/kraken/driver.html?testName=ai-astar) 07:45:06 INFO - PROCESS | 6820 | RSS: Main: 264712192 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | __start_tp_report 07:45:06 INFO - PROCESS | 6820 | _x_x_mozilla_page_load 07:45:06 INFO - PROCESS | 6820 | _x_x_mozilla_page_load_details 07:45:06 INFO - PROCESS | 6820 | |i|pagename|runs| 07:45:06 INFO - PROCESS | 6820 | |0;ai-astar;113;109;114;116;113;112;113;113;114;113 07:45:06 INFO - PROCESS | 6820 | |1;audio-beat-detection;158;131;133;190;133;162;163;132;207;131 07:45:06 INFO - PROCESS | 6820 | |2;audio-dft;161;163;160;162;161;161;162;168;161;161 07:45:06 INFO - PROCESS | 6820 | |3;audio-fft;77;76;78;126;76;76;77;77;99;76 07:45:06 INFO - PROCESS | 6820 | |4;audio-oscillator;85;84;123;84;85;84;126;85;84;117 07:45:06 INFO - PROCESS | 6820 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;118;119;118 07:45:06 INFO - PROCESS | 6820 | |6;imaging-darkroom;148;145;146;146;146;146;146;146;146;145 07:45:06 INFO - PROCESS | 6820 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;95 07:45:06 INFO - PROCESS | 6820 | |8;json-parse-financial;64;63;65;65;65;64;63;63;62;64 07:45:06 INFO - PROCESS | 6820 | |9;json-stringify-tinderbox;66;66;66;64;66;65;65;65;65;65 07:45:06 INFO - PROCESS | 6820 | |10;stanford-crypto-aes;91;84;84;81;85;85;85;84;114;83 07:45:06 INFO - PROCESS | 6820 | |11;stanford-crypto-ccm;136;134;130;134;134;132;147;133;136;137 07:45:06 INFO - PROCESS | 6820 | |12;stanford-crypto-pbkdf2;178;169;171;171;176;171;173;176;170;173 07:45:06 INFO - PROCESS | 6820 | |13;stanford-crypto-sha256-iterative;69;67;69;68;68;73;68;67;68;66 07:45:06 INFO - PROCESS | 6820 | __end_tp_report 07:45:06 INFO - PROCESS | 6820 | __start_cc_report 07:45:06 INFO - PROCESS | 6820 | _x_x_mozilla_cycle_collect,1903 07:45:06 INFO - PROCESS | 6820 | __end_cc_report 07:45:06 INFO - PROCESS | 6820 | __startTimestamp1464792306191__endTimestamp 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | ------- Summary: start ------- 07:45:06 INFO - PROCESS | 6820 | Number of tests: 14 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:1.76 (1.6%) stddev-sans-first:1.87 07:45:06 INFO - PROCESS | 6820 | Values: 113.0 109.0 114.0 116.0 113.0 112.0 113.0 113.0 114.0 113.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:160.00 stddev:27.26 (17.0%) stddev-sans-first:28.88 07:45:06 INFO - PROCESS | 6820 | Values: 158.0 131.0 133.0 190.0 133.0 162.0 163.0 132.0 207.0 131.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.26 (1.4%) stddev-sans-first:2.37 07:45:06 INFO - PROCESS | 6820 | Values: 161.0 163.0 160.0 162.0 161.0 161.0 162.0 168.0 161.0 161.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.00 stddev:16.42 (21.3%) stddev-sans-first:17.23 07:45:06 INFO - PROCESS | 6820 | Values: 77.0 76.0 78.0 126.0 76.0 76.0 77.0 77.0 99.0 76.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:18.28 (21.8%) stddev-sans-first:18.98 07:45:06 INFO - PROCESS | 6820 | Values: 85.0 84.0 123.0 84.0 85.0 84.0 126.0 85.0 84.0 117.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 07:45:06 INFO - PROCESS | 6820 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.44 07:45:06 INFO - PROCESS | 6820 | Values: 148.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:45:06 INFO - PROCESS | 6820 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 07:45:06 INFO - PROCESS | 6820 | Values: 64.0 63.0 65.0 65.0 65.0 64.0 63.0 63.0 62.0 64.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 07:45:06 INFO - PROCESS | 6820 | Values: 66.0 66.0 66.0 64.0 66.0 65.0 65.0 65.0 65.0 65.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:84.50 stddev:9.62 (11.4%) stddev-sans-first:10.12 07:45:06 INFO - PROCESS | 6820 | Values: 91.0 84.0 84.0 81.0 85.0 85.0 85.0 84.0 114.0 83.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.00 stddev:4.60 (3.4%) stddev-sans-first:4.87 07:45:06 INFO - PROCESS | 6820 | Values: 136.0 134.0 130.0 134.0 134.0 132.0 147.0 133.0 136.0 137.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:2.97 (1.7%) stddev-sans-first:2.49 07:45:06 INFO - PROCESS | 6820 | Values: 178.0 169.0 171.0 171.0 176.0 171.0 173.0 176.0 170.0 173.0 07:45:06 INFO - PROCESS | 6820 | 07:45:06 INFO - PROCESS | 6820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:1.99 07:45:06 INFO - PROCESS | 6820 | Values: 69.0 67.0 69.0 68.0 68.0 73.0 68.0 67.0 68.0 66.0 07:45:06 INFO - PROCESS | 6820 | -------- Summary: end -------- 07:45:06 INFO - PROCESS | 6820 | 07:45:07 INFO - TEST-INFO | 6820: exit 0 07:45:07 INFO - TEST-OK | kraken | took 64022ms 07:45:07 INFO - SUITE-END | took 1183s 07:45:07 INFO - Completed test suite (00:19:43) 07:45:07 INFO - javascript benchmark 07:45:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.853543055132, 2679.95980060299, 2698.9730102698973, 2714.8371097734125, 2724.673039235292, 4630.166570017395, 4698.436187657478, 4707.223308154151, 4756.334113224151, 4795.712257264562, 4692.554207350297, 4708.340832283483, 4712.693674911137, 4724.527547245274, 4743.8814029649275, 4288.614024737765, 4314.784260786963, 4372.5627437256335, 4398.626116780078, 4475.328700694889, 4405.933910991322, 4425.601695847373, 4426.933595996063, 4478.328250762379, 4492.730436173823, 4233.957660423387, 4284.228838809013, 4305.806238719265, 4321.9135617287475, 4362.541933097043, 4279.079997800488, 4284.207421627009, 4292.7424354538825, 4375.868723938287, 4408.911821763579, 4284.871453856389, 4289.957100429018, 4322.070754787705, 4329.9567004329865, 4347.0653809430805, 4503.437070366204, 4568.2462393705, 4589.2886602576655, 4602.447706275235, 4672.6261899047995, 5047.0, 5065.746712664389, 5069.493050694901, 5075.51782580658, 5081.695098294077, 5084.034033533617, 5099.745012749348, 5099.770510327045, 5101.20931255656, 5119.897602047939, 4552.180607490617, 4668.066386722669, 4731.739754313546, 4732.266498692708, 4746.762661866893, 5240.973795131076, 5255.054090263713, 5263.947360526346, 5275.788968441219, 5279.392869819943, 5001.824936127218, 5041.117804384291, 5043.84868453947, 5047.520485553867, 5048.949510504848, 4875.853724388274, 4955.331030310862, 5011.348524691767, 5019.799208031711, 5074.391073071181, 4944.134776414185, 4971.701697898137, 4974.1543937530705, 4978.054169707744, 5031.874203144951, 4956.083124621957, 4961.454240033593, 4969.3539839821315, 4973.254011898244, 5016.824411145592, 4112.444819949328, 4161.542230354658, 4167.458230430086, 4187.623113919762, 4188.91622167561, 3665.816709164531, 3695.519582454264, 3701.703863690952, 3732.402815549499, 3739.3456145174487, 4221.409002739619, 4225.471816022997, 4227.239096962515, 4263.4031235627035, 4277.165952639206, 4875.853724388274, 4927.334809800703, 4939.580135688435, 5030.522100400456, 5036.420811606712, 4175.791210439526, 4181.121964387452, 4196.496420429568, 4233.068724880522, 4241.7879106044575, 4489.932651010237, 4495.730256184639, 4504.909901801946, 4508.977455112769, 4549.909001820011, 4654.185517534485, 4741.620670346433, 4744.620430365493, 4765.976170119127, 4794.976025119852, 5080.669756465818, 5086.796528138833, 5096.694198348111, 5097.184450488053, 5152.76812543429, 4793.760311984317, 4809.711417314972, 4812.35033270518, 4821.590164835888, 4854.247591623304, 4831.661783675109, 4891.364122664031, 4939.901201976012, 4948.727819969936, 5069.366329208849, 5005.899882002413, 5023.120953833138, 5026.246063090565, 5027.145385284583, 5080.161773307511, 4870.586000190024, 4872.4153101628035, 4877.170880950318, 4884.877878053077, 4919.655624106278, 4751.572358487752, 4818.494058123846, 4868.245421959602, 4887.315775791321, 4895.975520122377, 4784.114938736345, 4837.927431088466, 4890.193118135468, 4891.364122664173, 4893.363862697969, 4811.037792441596, 4942.654014218971, 4950.183219768698, 4985.077760614298, 4989.376327959005, 4670.813167473263, 4740.691855029412, 4768.904621907612, 4804.303376010529, 4835.564799168092], "value": 4614.172939032637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5754510462525, 582.1616871704745, 583.7927535724821, 587.4037851580644, 600.7566935391167, 27465.17604471864, 39358.60641393581, 40269.19461610766, 40669.59330406695, 41177.79411102948, 38640.42039369405, 42772.78613606928, 42812.78593607035, 42885.0, 42920.57079429205, 7309.780706578785, 7702.537847729126, 7896.881546776803, 7903.40724445666, 9945.40327580344, 9769.413835169913, 10215.591376344937, 10228.079472847443, 10228.948855255714, 10231.437270950095, 10107.090361867431, 10207.336523125972, 10229.846552301722, 10233.437160956144, 10235.692929212135, 10146.188304935624, 10216.23378246627, 10227.437490937995, 10228.284020118595, 10236.488175591265, 10041.799164016678, 10060.798784024279, 10151.238657100674, 10159.59361625534, 10169.59321627134, 39567.80216098901, 40061.39907901384, 40124.398134028015, 40160.39759403611, 40185.0, 3239.8866039688733, 3278.8360581970805, 3297.1757060734817, 3306.93386132276, 3339.5825521809775, 29940.850295748383, 30342.54486182709, 30389.24026899323, 30537.38925221483, 31047.223819404695, 3359.428897087501, 3377.5946886373545, 3379.509971054208, 3387.8983630491125, 3405.557277553902, 250395.0, 251113.0, 252068.0, 252171.0, 253220.0, 54772.178417323776, 55229.0, 55247.342579722674, 55322.0, 55418.44581554214, 58450.0, 58480.12279815806, 58649.0, 58711.70644146752, 59036.7048164765, 14464.349104290332, 14991.0, 15035.323410446555, 15040.924795375953, 15047.172405517582, 11265.15511336653, 11470.59852905161, 11471.885281147082, 11472.082233421306, 11478.311301321948, 16353.264103115389, 16715.331386744394, 16887.831121688872, 16889.662206755795, 16903.32386704518, 5721.885562288731, 5866.472017518444, 5868.94131058684, 5932.6058376281535, 5947.375525569752, 801.7354273089867, 853.4964371021127, 869.8477766390856, 894.1237587164616, 901.3375169250595, 26654.46691066168, 28183.43633127367, 28237.29406764806, 28622.85688571544, 28700.569491457645, 861.4700569681797, 929.0384452092052, 997.7378616050702, 1038.2161468091542, 1054.4569546683465, 14925.626859328604, 15255.771163432557, 15317.31072101758, 15390.615234619225, 15440.472390679895, 381798.0, 382535.0, 383807.0, 383831.0, 384100.0, 50252.0, 50987.0, 51370.74314628403, 51385.0, 51607.48392516102, 1094.5074716377662, 1157.5080590748898, 1192.2250537150921, 1219.5609580550995, 1249.1505776072358, 26110.34724131912, 29360.41279174447, 30001.849990749906, 30281.0, 30435.0, 42538.57461425346, 42844.0, 42983.570164297955, 43083.569164307955, 43097.569024309356, 247407.0, 247568.0, 248130.0, 248858.0, 249071.0, 22498.325050248517, 24222.63666045046, 25219.117330893332, 25409.87295063513, 26517.60223596686, 42679.57320426756, 43525.56474435342, 43646.56353436425, 44253.55746442494, 44844.775776120914, 37072.25855482929, 37173.070673233386, 37232.25535489221, 37679.0, 37936.0, 36982.26035479221, 37234.813825930694, 37767.0, 37924.0, 37926.810365948, 35733.64266357303, 36042.27915441729, 36438.453423198145, 36856.26287474182, 36866.0, 32077.518837217925, 33612.831935840164, 33773.0, 33992.66007339994, 34036.14909627279, 25421.745782541937, 25488.0, 25769.484610307314, 25775.742242578086, 26234.21297361082], "value": 18092.96100020517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.95375578052744, 376.75134411288536, 380.75060835152976, 394.06213212554115, 394.48125714685204, 15696.372145114196, 16057.357705691773, 16737.16314184292, 16764.32942682293, 16770.245338959747, 11039.779204415907, 11042.779144417127, 11046.116310695144, 11047.337159770399, 11251.268667536604, 4540.2054640437955, 4610.838620648278, 4618.261078227484, 4666.789994450241, 4671.0, 4671.112488627167, 4716.599089077416, 4755.381800365947, 4761.714297142165, 4777.020710754305, 4733.313669517918, 4780.115678599453, 4780.282957556359, 4780.856574302759, 4821.204501257306, 4647.395838540985, 4760.976195119037, 4772.73749943753, 4781.593564547018, 4823.855284341475, 4404.559544045602, 4651.2557990721325, 4652.371929789469, 4654.045920586272, 4657.998530315998, 11191.384473853936, 12354.0, 12395.876041239653, 12483.438245278985, 12485.0, 1805.0523475175507, 1890.4801179675699, 1902.6194761047846, 1904.3430016644375, 2016.8184863362367, 8942.508162051085, 9005.594748236344, 9165.083491650781, 9286.674966376144, 9373.671921482715, 1538.9384424623001, 1539.5227479481396, 1607.3249235321193, 1630.812456567498, 1638.6313079557124, 67462.66268668625, 68325.0, 68363.31636683669, 68468.6576567114, 68481.0, 10013.39919604826, 10083.0, 10100.292979491513, 10170.338927969806, 10275.434851083262, 13999.580012599637, 14024.649383765283, 14029.85970140306, 14080.22558759278, 14123.034162825921, 7074.327938845904, 7185.497015208885, 7186.461015423864, 7248.9275107249305, 7255.0, 6672.165979252593, 6715.899261511081, 6759.763408280785, 6808.08090907731, 6863.485238607124, 4296.935545966813, 4316.597105940582, 4353.782310884507, 4376.890577735582, 4386.824527018947, 1858.27527264367, 1879.9624007519774, 1894.2896413844808, 1899.3067530351323, 1912.244663357966, 816.603947085663, 865.2947847504264, 920.2132176988712, 951.9286053546011, 953.5041778275397, 16280.10459424743, 16297.592560185853, 16432.096234706965, 16591.41930032443, 16822.990620562807, 860.63627730294, 882.1443200095897, 891.913977637369, 936.017181958954, 941.9340646154841, 9115.635374585076, 9402.01278865723, 9454.95272523633, 9469.289803264783, 9641.951790241144, 354718.0, 371857.0, 373117.0, 373159.0, 379427.0, 56628.716856415456, 70945.0, 76162.61918690371, 76461.23538764541, 79108.60445697735, 872.4983134697447, 878.6473794466046, 880.0539420123393, 906.3112034853427, 909.4770506958525, 11560.537578497102, 14317.713645727235, 14797.778033329723, 15260.0, 15283.847161528241, 31501.369972600878, 32506.512402314456, 32523.186920326236, 35350.82324588361, 35968.0, 43620.56379436165, 45140.32289515725, 45326.32010519779, 51183.232251517, 51929.0, 7190.6404679764755, 7428.554286742813, 7444.292792184734, 7533.434992375484, 7561.054868141482, 10298.948505257425, 10812.56749730002, 10820.891791082304, 10859.131269498579, 10904.127669786556, 8764.517951512727, 9201.171894529256, 9523.619055237712, 9634.90365096368, 9663.46850923206, 9315.6273749052, 9523.61905523799, 9734.659286924923, 9933.801323973335, 9991.350562213433, 6429.839254018687, 9482.525873706149, 9527.142557169887, 9798.75503112428, 9842.311038227543, 7339.0, 7388.4828062037295, 7474.514156579805, 7520.097588289222, 7551.73568925085, 8267.379946504156, 8893.377463577488, 9079.727608171765, 9082.364234503786, 9230.35387522867], "value": 7640.207262392309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.838156848825, 1388.6736616895032, 1395.602253357793, 1503.9774403383951, 1719.9140042997856, 6785.084013658155, 7541.924580754191, 7621.58081305528, 7700.807479813, 8001.3998950078685, 7650.311471967521, 7839.333656639193, 7852.175521570239, 7852.764417067498, 7860.292573668368, 2128.3189379398636, 2153.493928926701, 2156.924507642233, 2158.7841215878443, 2159.125554150564, 2099.4226587688354, 2122.3632910126976, 2203.0, 2204.6252137136726, 2208.7570367259586, 2110.7889211078846, 2150.5591353772516, 2151.591197672445, 2157.072458842697, 2159.492519257973, 2125.4898824282136, 2130.211821625993, 2134.157007981846, 2134.178341338588, 2136.2309568555306, 2085.4682056075753, 2159.0176469706403, 2161.978380216209, 2162.7837216278404, 2166.880821554814, 7608.695652173907, 7779.144294127642, 7825.530468171871, 7865.724699635485, 7868.72459463916, 4460.866174014753, 4638.721676699409, 4639.559241872017, 4640.211164102111, 4642.14120387726, 2661.5342315094977, 2772.4039331543813, 2817.0281252967693, 2824.166870773127, 2829.0381270368175, 855.0, 868.9956550217208, 874.9475031498131, 883.3110174064241, 898.7079199260266, 10429.113525350354, 10699.144068474503, 10737.355758654428, 10744.0, 10747.785044299148, 4149.771762553029, 4228.640565551963, 4295.806688699016, 4300.440942677432, 4302.526722060571, 9230.53847307632, 9256.16694497485, 9267.953660231655, 9298.163165315154, 9313.39462934907, 4565.6119229865835, 4643.767811609406, 4645.140648979949, 4646.210144275481, 4651.5813576778255, 3713.8700145494777, 4089.0, 4232.830686772556, 4242.384854196124, 4293.291606884829, 3680.7791532508136, 3764.9435258471144, 3801.353769859131, 3831.750936189139, 3847.8460861565222, 1194.713268815478, 1211.357980270458, 1220.5483970930634, 1221.6090850927797, 1227.8342423772676, 796.223681910133, 799.3165843204093, 826.2398593294183, 840.7940054686519, 928.2295694573488, 5319.1223448131395, 5604.8038318658655, 5616.297962754656, 5709.115087161496, 5721.199032135504, 382.8793929912069, 383.2813474734872, 384.9210911763138, 387.9379299312153, 397.8408636545405, 3822.866199682998, 3909.4331321958157, 3917.5494818095713, 3943.9014024649614, 3962.9405558916637, 9423.0, 9679.177269931994, 9831.557579908922, 9838.852417213748, 9843.803123937481, 9592.232621390272, 9706.90293097074, 9717.6598819041, 9732.0, 9748.122668959828, 7194.604296763729, 7446.441516886255, 7448.4041276697735, 7462.44031697614, 7463.738769143162, 5414.160805075219, 5485.670859748428, 5583.2462617547735, 5643.943560564506, 5669.036263835075, 8637.754183912102, 8789.91210087891, 9051.864222036806, 9055.320850936074, 9068.22920051803, 8989.538338618053, 9156.130167634064, 9176.128267814547, 9194.218491428035, 9247.306452015991, 6267.655278959519, 6455.838604034749, 6464.773732919325, 6987.475939304471, 7063.117110361205, 6791.524593278423, 7603.771886843404, 7604.771856844303, 7787.844243114992, 7797.454178207471, 6596.769113081019, 6790.219124800711, 6871.896921546281, 6906.205786334636, 6923.653817309215, 6830.31696830313, 6852.451803855779, 6901.137357830271, 6903.93096069053, 6922.169339679271, 6480.805575832733, 6546.312637173219, 6549.901751473827, 6552.312007239171, 6688.565243259172, 4897.730624815669, 4915.139850526072, 4994.9500504994485, 4999.500049994971, 5018.4730603286125, 4989.501049894981, 4998.1253280676465, 4999.600031997359, 5053.59571234293, 5136.640435169502], "value": 4094.005104393067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.78664934545816, 309.1344236138811, 310.04815217282936, 311.4782738912322, 312.87954137656993, 4911.2633105034265, 4959.553640172384, 4963.751812409383, 4968.130577149002, 4976.377952755905, 4867.780949857256, 4890.266460030997, 4892.828750993716, 4903.754812259391, 4909.214525675892, 3658.9817050914776, 3761.887143385703, 3780.092777733352, 3838.193979264358, 3870.0518372998654, 3819.8281077351585, 3845.4039623858207, 3849.480320156771, 3868.5686296070494, 3870.903227419323, 3676.1728611062563, 3858.5562660294145, 3860.073582340232, 3869.419587061949, 3873.845046198149, 3661.5789184243754, 3793.9810300948457, 3800.1259710266795, 3828.9808550957346, 3868.2650296443867, 3365.6129545102135, 3367.3770352484626, 3374.645662205482, 3397.6432474590306, 3398.2863598644312, 4652.185867473178, 4653.232216684277, 4662.277347011219, 4673.719576825401, 4723.504032076651, 4268.146370725836, 4372.27857403528, 4374.58441448062, 4410.412251589425, 4412.713173643703, 5015.4733752956145, 5096.719680417613, 5141.074606570815, 5141.794328226866, 5143.922841157386, 3689.1330537323706, 3695.796731179784, 3702.851885924587, 3712.7215458840697, 3727.552693676776, 5267.920981185285, 5300.946990530084, 5336.199570064483, 5382.381026181961, 5410.864728381783, 3755.6807671347697, 3763.1909139535132, 3783.697304215656, 3784.375578029649, 3797.9620203798163, 3839.8080095995088, 3848.634379733921, 3854.2676891390547, 3856.82644281008, 3858.9421158682644, 4341.7829108545075, 4342.0, 4360.49854266757, 4381.751200907726, 4390.407295015132, 4930.309756634074, 5064.696118232918, 5071.46749591295, 5099.974500127476, 5105.723569107723, 1291.8320618319747, 1322.3983087695076, 1327.143992125074, 1331.7602831490424, 1334.5996201139812, 850.6002178975872, 870.3298460185622, 891.8751374807532, 892.7723430525305, 894.3158483759929, 4247.49030116388, 4265.1043280910735, 4372.497162826316, 4377.759223242752, 4409.691321607456, 5207.973960130175, 5213.679912438928, 5217.843464696065, 5218.869528261824, 5227.797606550439, 4211.894702632398, 4398.978005109954, 4404.823807047682, 4409.382686423904, 4420.58004489573, 2788.3029242689327, 2799.1042866283, 2799.2721892308145, 2806.5228911085164, 2822.618946442245, 4983.27742477346, 4986.750662466862, 4994.2508623706735, 5001.249812528077, 5001.799928002839, 5132.820351287762, 5377.462253774669, 5414.160805075219, 5431.755570999315, 5473.0, 4898.0, 4926.088673595468, 4947.0, 5042.394912610437, 5056.6713163644245, 5212.748940254388, 5240.135377662643, 5257.947420525746, 5285.867853303698, 5291.629585928948, 5080.282049103712, 5233.241180028798, 5250.921236181537, 5252.763625636932, 5252.789888404421, 4928.14167782678, 4962.42932062803, 4966.652334336562, 5024.4473107957365, 5026.84919452417, 3728.161163738137, 3730.403135498307, 3745.812709364466, 3764.7199952016445, 3806.695464362789, 5145.459726728789, 5199.399233231846, 5267.446918073547, 5269.631125821155, 5337.572994160536, 5064.924026139537, 5066.898662026665, 5067.41724701664, 5112.233165025276, 5136.30659860914, 5134.358205224347, 5136.871578210575, 5145.009340939283, 5151.278820965143, 5175.094358487175, 4833.830815921426, 4913.336699545515, 5077.796888124433, 5158.767855446589, 5168.276441298146, 5005.623453550303, 5157.0, 5165.457626949266, 5179.274901513866, 5195.6622819516615, 5021.1464051112125, 5068.6451948363265, 5070.746462676925, 5081.8729531762, 5093.337866077386], "value": 3868.0436333198304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.3879328861074, 636.1729751323279, 671.506442764568, 683.9452843772499, 723.0780754537964, 11749.588764393247, 12396.690082747913, 12404.31776252307, 12430.627081187557, 12434.875651243485, 11840.993515551188, 12282.508699652026, 12296.07779416545, 12316.938415307934, 12355.444005019774, 783.6121120045557, 791.1811275330034, 798.5288679678988, 800.9919900800976, 801.7995501124719, 777.4985134588187, 781.2421950707804, 787.016229712859, 787.6691789448416, 789.4513313247295, 836.1680128272377, 836.9874451883227, 838.0153319849184, 838.1409055717908, 838.4801423117675, 833.2625626320689, 835.2065537739142, 835.5112259328331, 835.7534527314426, 835.8579041562949, 607.1803065861052, 610.4963405190691, 610.5725991805709, 610.5848023344124, 610.8656095658948, 11134.665960021212, 11142.944285278521, 11181.72045698856, 11195.832062519068, 11207.327560346404, 10208.183345332356, 10335.22485813567, 10437.895621043768, 10458.267921245515, 10462.0, 8868.0, 8965.372423930328, 9112.134347237068, 9203.987561368243, 9326.766830829283, 3197.696218859228, 3297.0, 3301.339732053575, 3361.3949489091956, 3389.305192435545, 35955.460668089996, 39711.8014409929, 42203.57796422027, 42413.787931060455, 44680.55319446797, 10292.485375731334, 10414.271001030007, 10424.68725938223, 10557.313774604627, 10646.89353106459, 17678.29286828538, 17697.823021769877, 17805.376811811526, 17831.73252401215, 17849.0, 6986.476014298948, 7069.646517674096, 7074.111151859969, 7125.608091555015, 7283.089613798275, 3768.340540405418, 3793.0327766419387, 3794.2356804086235, 3803.505544279226, 3807.352750032446, 2853.885844566194, 2940.088572542476, 2943.058221369184, 2946.1897978056204, 2947.469455497988, 506.39485814451376, 516.068496364059, 520.885405210853, 522.0602914753505, 523.1107117899586, 494.178950567154, 589.3634874335708, 601.0413390641919, 614.2782230878789, 641.0992555459587, 8334.208250216341, 8337.833243335099, 8358.498490090615, 8468.364872634455, 8544.40189186751, 499.37827404881153, 541.8564080518665, 574.643720893049, 613.929398119213, 631.6967855429419, 3920.353141731582, 3953.802309884494, 3961.3661814110183, 4039.2527382434346, 4042.292598795199, 47799.76100119477, 49668.50331496711, 49749.0, 54541.454585454434, 55032.449675503536, 47935.76032119817, 48549.0, 48927.510724892294, 49910.50089499131, 49920.50079499231, 45228.547714522436, 45239.321410178876, 45622.771886140355, 45698.543014569426, 46706.299405508944, 8310.916890831015, 8438.240558349778, 8541.914580854113, 8560.101189375026, 8656.697015604424, 30636.693633064275, 31754.206144846565, 32129.67870321267, 32230.516542252353, 32473.188170295933, 40011.79994100011, 40094.599054009086, 40419.595804041586, 40452.39321410123, 40884.0, 10102.646407375707, 10203.183745300506, 10262.794744104927, 10403.271770975958, 10505.107065899485, 11288.830667539829, 11572.305661660328, 11677.299362038304, 12244.142909996215, 12260.448279827251, 11073.833892491459, 11747.706307342385, 11775.705607359885, 11808.11439142085, 11827.349495777815, 11031.22781405294, 11182.440877956233, 11451.370174640475, 11744.236624619372, 11757.76484470323, 11252.099832013582, 11281.09751219884, 11576.479058442223, 11596.188266821242, 11628.825567616323, 9570.554600343732, 9691.370060946016, 9777.41335519871, 9861.506924653595, 9862.950685246527, 8055.476394034369, 8295.170482951657, 9274.6290148396, 9591.568379423083, 9775.85336219943], "value": 5930.118766882509, "unit": "score"}], "name": "dromaeo_css", "value": 6255.234960090553, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 116.0, 113.0, 112.0, 113.0, 113.0, 114.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 133.0, 190.0, 133.0, 162.0, 163.0, 132.0, 207.0, 131.0], "value": 154.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 161.0, 161.0, 162.0, 168.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 126.0, 76.0, 76.0, 77.0, 77.0, 99.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 84.0, 85.0, 84.0, 126.0, 85.0, 84.0, 117.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 64.0, 63.0, 63.0, 62.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 84.0, 84.0, 81.0, 85.0, 85.0, 85.0, 84.0, 114.0, 83.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 130.0, 134.0, 134.0, 132.0, 147.0, 133.0, 136.0, 137.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 169.0, 171.0, 171.0, 176.0, 171.0, 173.0, 176.0, 170.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 68.0, 68.0, 73.0, 68.0, 67.0, 68.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1560.0999999999997, "alertThreshold": 2.0}]} 07:45:07 INFO - Return code: 0 07:45:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:45:07 ERROR - # TBPL SUCCESS # 07:45:07 INFO - Running post-action listener: _resource_record_post_action 07:45:07 INFO - ##### 07:45:07 INFO - ##### Finished run-tests step (success) 07:45:07 INFO - ##### 07:45:07 INFO - Running post-run listener: _resource_record_post_run 07:45:07 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525950976; Read time: 12; Write time: 405792 07:45:07 INFO - TinderboxPrint: CPU usage
13.1% 07:45:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:45:07 INFO - TinderboxPrint: I/O write bytes / time
525,950,976 / 405,792 07:45:07 INFO - TinderboxPrint: CPU idle
8,321.7 (86.9%) 07:45:07 INFO - TinderboxPrint: CPU user
1,212.6 (12.7%) 07:45:07 INFO - TinderboxPrint: Swap in / out
0 / 0 07:45:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246145024; Read time: 0; Write time: 238152 07:45:07 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279805952; Read time: 12; Write time: 167640 07:45:08 INFO - Running post-run listener: _upload_blobber_files 07:45:08 INFO - Blob upload gear active. 07:45:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07: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 07: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'] 07: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 07:45:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:10 INFO - (blobuploader) - INFO - Done attempting. 07:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:11 INFO - (blobuploader) - INFO - Done attempting. 07:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:15 INFO - (blobuploader) - INFO - Done attempting. 07:45:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:15 INFO - Return code: 0 07:45:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83c89c0f7484db39858aa64bd881ec4bbec1af1d8ee2ad7582b69a5d02c984a5da0a4479b3b0b53dd369dc7be49f4d4da3c7cb67c33d43f03d6c55f82a0a36bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/890b907749dcc0214138a1faccd3cfc9d3b00728e618e52e51bc58b475981ae02a7d04e62f7a35377dd5ffb06baae8f73ab9d38e9a4e9e30bb2af0448bc27452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81f4fe8e7bc5999d6615cee390314d3c1978f3d02a018d3e6e75015a15e46ffd97c7d314c066886e88e0f1e35ba061989b121427b2ab96c475800bfbe1595220"} 07:45:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:15 INFO - Contents: 07:45:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83c89c0f7484db39858aa64bd881ec4bbec1af1d8ee2ad7582b69a5d02c984a5da0a4479b3b0b53dd369dc7be49f4d4da3c7cb67c33d43f03d6c55f82a0a36bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/890b907749dcc0214138a1faccd3cfc9d3b00728e618e52e51bc58b475981ae02a7d04e62f7a35377dd5ffb06baae8f73ab9d38e9a4e9e30bb2af0448bc27452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81f4fe8e7bc5999d6615cee390314d3c1978f3d02a018d3e6e75015a15e46ffd97c7d314c066886e88e0f1e35ba061989b121427b2ab96c475800bfbe1595220"} 07:45:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:15 INFO - Copying logs to upload dir... 07:45:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.092680 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-01 07:45:15.582321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:15.586139) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 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/83c89c0f7484db39858aa64bd881ec4bbec1af1d8ee2ad7582b69a5d02c984a5da0a4479b3b0b53dd369dc7be49f4d4da3c7cb67c33d43f03d6c55f82a0a36bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/890b907749dcc0214138a1faccd3cfc9d3b00728e618e52e51bc58b475981ae02a7d04e62f7a35377dd5ffb06baae8f73ab9d38e9a4e9e30bb2af0448bc27452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81f4fe8e7bc5999d6615cee390314d3c1978f3d02a018d3e6e75015a15e46ffd97c7d314c066886e88e0f1e35ba061989b121427b2ab96c475800bfbe1595220"} build_url:https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/W_XOc2RaSKmg076k0GtNtg/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/83c89c0f7484db39858aa64bd881ec4bbec1af1d8ee2ad7582b69a5d02c984a5da0a4479b3b0b53dd369dc7be49f4d4da3c7cb67c33d43f03d6c55f82a0a36bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/890b907749dcc0214138a1faccd3cfc9d3b00728e618e52e51bc58b475981ae02a7d04e62f7a35377dd5ffb06baae8f73ab9d38e9a4e9e30bb2af0448bc27452", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/81f4fe8e7bc5999d6615cee390314d3c1978f3d02a018d3e6e75015a15e46ffd97c7d314c066886e88e0f1e35ba061989b121427b2ab96c475800bfbe1595220"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:15.611359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:15.611665) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464791070.693101-171397764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-01 07:45:15.695514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:45:15.695846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-01 07:45:15.696146) ========= ========= Total master_lag: 0.18 =========