builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1462889288.9 results: success (0) buildid: 20160510043041 builduid: df7528089a5e4323a34864d63c8f5534 revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.899143) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.900289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.900913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.937173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:08.937582) ========= 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=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 07:08:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-10 07:08:09 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.028842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.029465) ========= 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=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.081855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.082668) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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 1579b9e2e50f3a27ad02d58cc9170c91e0973fec --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=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 07:08:09,318 truncating revision to first 12 chars 2016-05-10 07:08:09,318 Setting DEBUG logging. 2016-05-10 07:08:09,318 attempt 1/10 2016-05-10 07:08:09,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1579b9e2e50f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 07:08:09,600 unpacking tar archive at: mozilla-central-1579b9e2e50f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554740 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.655560) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.656255) ========= script_repo_revision: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.657246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.657958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 07:08:09.668666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-10 07:08:09.668983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:09 INFO - MultiFileLogger online at 20160510 07:08:09 in /builds/slave/test 07:08:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:08:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:09 INFO - {'append_to_log': False, 07:08:09 INFO - 'base_work_dir': '/builds/slave/test', 07:08:09 INFO - 'blob_upload_branch': 'Firefox', 07:08:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:09 INFO - 'branch': 'Firefox', 07:08:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:09 INFO - 'config_files': ('talos/linux_config.py',), 07:08:09 INFO - 'default_actions': ('clobber', 07:08:09 INFO - 'read-buildbot-config', 07:08:09 INFO - 'download-and-extract', 07:08:09 INFO - 'populate-webroot', 07:08:09 INFO - 'create-virtualenv', 07:08:09 INFO - 'install', 07:08:09 INFO - 'run-tests'), 07:08:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:09 INFO - 'download_minidump_stackwalk': True, 07:08:09 INFO - 'download_symbols': 'ondemand', 07:08:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:09 INFO - 'installer_path': 'installer.exe', 07:08:09 INFO - 'log_level': 'info', 07:08:09 INFO - 'log_name': 'talos', 07:08:09 INFO - 'log_to_console': True, 07:08:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:09 INFO - 'opt_config_files': (), 07:08:09 INFO - 'pip_index': False, 07:08:09 INFO - 'sps_profile': False, 07:08:09 INFO - 'sps_profile_interval': 0, 07:08:09 INFO - 'suite': 'dromaeojs-e10s', 07:08:09 INFO - 'system_bits': '32', 07:08:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:09 INFO - 'title': 'talos-linux64-ix-056', 07:08:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:09 INFO - 'use_talos_json': True, 07:08:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:09 INFO - 'work_dir': 'build'} 07:08:09 INFO - ##### 07:08:09 INFO - ##### Running clobber step. 07:08:09 INFO - ##### 07:08:09 INFO - Running pre-action listener: _resource_record_pre_action 07:08:09 INFO - Running main action method: clobber 07:08:09 INFO - rmtree: /builds/slave/test/build 07:08:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:10 INFO - Running post-action listener: _resource_record_post_action 07:08:10 INFO - ##### 07:08:10 INFO - ##### Finished clobber step (success) 07:08:10 INFO - ##### 07:08:10 INFO - ##### 07:08:10 INFO - ##### Running read-buildbot-config step. 07:08:10 INFO - ##### 07:08:10 INFO - Running pre-action listener: _resource_record_pre_action 07:08:10 INFO - Running main action method: read_buildbot_config 07:08:10 INFO - Using buildbot properties: 07:08:10 INFO - { 07:08:10 INFO - "project": "", 07:08:10 INFO - "product": "firefox", 07:08:10 INFO - "script_repo_revision": "production", 07:08:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:08:10 INFO - "repository": "", 07:08:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:08:10 INFO - "buildid": "20160510043041", 07:08:10 INFO - "pgo_build": "True", 07:08:10 INFO - "basedir": "/builds/slave/test", 07:08:10 INFO - "buildnumber": 195, 07:08:10 INFO - "slavename": "talos-linux64-ix-056", 07:08:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:08:10 INFO - "platform": "ubuntu64_hw", 07:08:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:08:10 INFO - "branch": "mozilla-central", 07:08:10 INFO - "repo_path": "mozilla-central", 07:08:10 INFO - "revision": "1579b9e2e50f3a27ad02d58cc9170c91e0973fec", 07:08:10 INFO - "stage_platform": "linux64-pgo", 07:08:10 INFO - "builduid": "df7528089a5e4323a34864d63c8f5534", 07:08:10 INFO - "slavebuilddir": "test" 07:08:10 INFO - } 07:08:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:08:10 INFO - Running post-action listener: _resource_record_post_action 07:08:10 INFO - ##### 07:08:10 INFO - ##### Finished read-buildbot-config step (success) 07:08:10 INFO - ##### 07:08:10 INFO - ##### 07:08:10 INFO - ##### Running download-and-extract step. 07:08:10 INFO - ##### 07:08:10 INFO - Running pre-action listener: _resource_record_pre_action 07:08:10 INFO - Running main action method: download_and_extract 07:08:10 INFO - mkdir: /builds/slave/test/build/tests 07:08:10 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:08:10 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:17 INFO - Downloaded 1361 bytes. 07:08:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:08:17 INFO - Using the following test package requirements: 07:08:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'jsshell-linux-x86_64.zip'], 07:08:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:17 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:23 INFO - Downloaded 23898987 bytes. 07:08:23 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:08:23 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:08:24 INFO - Return code: 0 07:08:24 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:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:24 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:27 INFO - Downloaded 23898987 bytes. 07:08:27 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:08:27 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:08:28 INFO - Return code: 0 07:08:28 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:08:28 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:29 INFO - Downloaded 10840152 bytes. 07:08:29 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:08:29 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:08:29 INFO - Return code: 0 07:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:29 INFO - https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAUAHJPDQxySiWOy9ZBjKw/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:08:31 INFO - Downloaded 58344040 bytes. 07:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:31 INFO - mkdir: /builds/slave/test/properties 07:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:31 INFO - Contents: 07:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:08:31 INFO - Running post-action listener: _resource_record_post_action 07:08:31 INFO - Running post-action listener: set_extra_try_arguments 07:08:31 INFO - ##### 07:08:31 INFO - ##### Finished download-and-extract step (success) 07:08:31 INFO - ##### 07:08:31 INFO - ##### 07:08:31 INFO - ##### Running populate-webroot step. 07:08:31 INFO - ##### 07:08:31 INFO - Running pre-action listener: _resource_record_pre_action 07:08:31 INFO - Running main action method: populate_webroot 07:08:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:32 INFO - '--tppagecycles', 07:08:32 INFO - '7'], 07:08:32 INFO - 'tests': ['tsvgm']}}, 07:08:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['damp', 'tps']}, 07:08:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['damp', 'tps']}, 07:08:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['dromaeo_dom']}, 07:08:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['a11yr', 07:08:32 INFO - 'ts_paint', 07:08:32 INFO - 'tpaint', 07:08:32 INFO - 'sessionrestore', 07:08:32 INFO - 'sessionrestore_no_auto_restore', 07:08:32 INFO - 'tabpaint']}, 07:08:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tsvgx', 07:08:32 INFO - 'tsvgr_opacity', 07:08:32 INFO - 'tart', 07:08:32 INFO - 'tscrollx', 07:08:32 INFO - 'cart']}, 07:08:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:32 INFO - 'tsvgr_opacity', 07:08:32 INFO - 'tart', 07:08:32 INFO - 'tscrollx', 07:08:32 INFO - 'cart']}, 07:08:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s'], 07:08:32 INFO - 'tests': ['tp5o']}, 07:08:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'tests': ['tp5o']}, 07:08:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--disable-e10s', 07:08:32 INFO - '--xperf_path', 07:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:32 INFO - 'tests': ['tp5n']}, 07:08:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:32 INFO - 'talos_options': ['--xperf_path', 07:08:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:32 INFO - 'tests': ['tp5n']}}, 07:08:32 INFO - 'talos.zip': {'path': '', 07:08:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:32 INFO - Running post-action listener: _resource_record_post_action 07:08:32 INFO - ##### 07:08:32 INFO - ##### Finished populate-webroot step (success) 07:08:32 INFO - ##### 07:08:32 INFO - ##### 07:08:32 INFO - ##### Running create-virtualenv step. 07:08:32 INFO - ##### 07:08:32 INFO - Running pre-action listener: _resource_record_pre_action 07:08:32 INFO - Running main action method: create_virtualenv 07:08:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08:32 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:08:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:32 INFO - Using real prefix '/usr' 07:08:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:32 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:34 INFO - Installing pip.................done. 07:08:34 INFO - Return code: 0 07:08:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08:34 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:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 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:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:34 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:08:34 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:08:34 INFO - Using env: {'DISPLAY': ':0', 07:08:34 INFO - 'HOME': '/home/cltbld', 07:08:34 INFO - 'LANG': 'en_US.UTF-8', 07:08:34 INFO - 'LANGUAGE': 'en_US:en', 07:08:34 INFO - 'LOGNAME': 'cltbld', 07:08:34 INFO - 'MAIL': '/var/mail/cltbld', 07:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:34 INFO - 'MOZ_NO_REMOTE': '1', 07:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:34 INFO - 'NO_EM_RESTART': '1', 07:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:34 INFO - 'PWD': '/builds/slave/test', 07:08:34 INFO - 'SHELL': '/bin/bash', 07:08:34 INFO - 'SHLVL': '1', 07:08:34 INFO - 'TERM': 'linux', 07:08:34 INFO - 'TMOUT': '86400', 07:08:34 INFO - 'USER': 'cltbld', 07:08:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:34 INFO - '_': '/tools/buildbot/bin/python'} 07:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:34 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:08:34 INFO - Cleaning up... 07:08:34 INFO - Return code: 0 07:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:08:34 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:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 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:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:34 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:34 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>=0.7.1'] in /builds/slave/test/build 07:08:34 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>=0.7.1 07:08:34 INFO - Using env: {'DISPLAY': ':0', 07:08:34 INFO - 'HOME': '/home/cltbld', 07:08:34 INFO - 'LANG': 'en_US.UTF-8', 07:08:34 INFO - 'LANGUAGE': 'en_US:en', 07:08:34 INFO - 'LOGNAME': 'cltbld', 07:08:34 INFO - 'MAIL': '/var/mail/cltbld', 07:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:34 INFO - 'MOZ_NO_REMOTE': '1', 07:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:34 INFO - 'NO_EM_RESTART': '1', 07:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:34 INFO - 'PWD': '/builds/slave/test', 07:08:34 INFO - 'SHELL': '/bin/bash', 07:08:34 INFO - 'SHLVL': '1', 07:08:34 INFO - 'TERM': 'linux', 07:08:34 INFO - 'TMOUT': '86400', 07:08:34 INFO - 'USER': 'cltbld', 07:08:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:34 INFO - '_': '/tools/buildbot/bin/python'} 07:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:35 INFO - Downloading/unpacking psutil>=0.7.1 07:08:35 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:08:35 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:08:35 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:08:35 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:08:35 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:08:35 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:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:36 INFO - Installing collected packages: psutil 07:08:36 INFO - Running setup.py install for psutil 07:08:37 INFO - building 'psutil._psutil_linux' extension 07:08:37 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:08:37 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:08:37 INFO - building 'psutil._psutil_posix' extension 07:08:37 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:08:37 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:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:37 INFO - Successfully installed psutil 07:08:37 INFO - Cleaning up... 07:08:37 INFO - Return code: 0 07:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:37 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:37 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.0.0'] in /builds/slave/test/build 07:08:37 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.0.0 07:08:37 INFO - Using env: {'DISPLAY': ':0', 07:08:37 INFO - 'HOME': '/home/cltbld', 07:08:37 INFO - 'LANG': 'en_US.UTF-8', 07:08:37 INFO - 'LANGUAGE': 'en_US:en', 07:08:37 INFO - 'LOGNAME': 'cltbld', 07:08:37 INFO - 'MAIL': '/var/mail/cltbld', 07:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:37 INFO - 'MOZ_NO_REMOTE': '1', 07:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:37 INFO - 'NO_EM_RESTART': '1', 07:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:37 INFO - 'PWD': '/builds/slave/test', 07:08:37 INFO - 'SHELL': '/bin/bash', 07:08:37 INFO - 'SHLVL': '1', 07:08:37 INFO - 'TERM': 'linux', 07:08:37 INFO - 'TMOUT': '86400', 07:08:37 INFO - 'USER': 'cltbld', 07:08:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:37 INFO - '_': '/tools/buildbot/bin/python'} 07:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:08:39 INFO - Installing collected packages: mozsystemmonitor 07:08:39 INFO - Running setup.py install for mozsystemmonitor 07:08:39 INFO - Successfully installed mozsystemmonitor 07:08:39 INFO - Cleaning up... 07:08:39 INFO - Return code: 0 07:08:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08: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:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:39 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:39 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:08:39 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:08:39 INFO - Using env: {'DISPLAY': ':0', 07:08:39 INFO - 'HOME': '/home/cltbld', 07:08:39 INFO - 'LANG': 'en_US.UTF-8', 07:08:39 INFO - 'LANGUAGE': 'en_US:en', 07:08:39 INFO - 'LOGNAME': 'cltbld', 07:08:39 INFO - 'MAIL': '/var/mail/cltbld', 07:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:39 INFO - 'MOZ_NO_REMOTE': '1', 07:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:39 INFO - 'NO_EM_RESTART': '1', 07:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:39 INFO - 'PWD': '/builds/slave/test', 07:08:39 INFO - 'SHELL': '/bin/bash', 07:08:39 INFO - 'SHLVL': '1', 07:08:39 INFO - 'TERM': 'linux', 07:08:39 INFO - 'TMOUT': '86400', 07:08:39 INFO - 'USER': 'cltbld', 07:08:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:39 INFO - '_': '/tools/buildbot/bin/python'} 07:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:41 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:08:41 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:08:41 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:08:41 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:08:41 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:08:41 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:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:42 INFO - Downloading docopt-0.6.1.tar.gz 07:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:42 INFO - Running setup.py install for blobuploader 07:08:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:42 INFO - Running setup.py install for requests 07:08:43 INFO - Running setup.py install for docopt 07:08:43 INFO - Successfully installed blobuploader requests docopt 07:08:43 INFO - Cleaning up... 07:08:43 INFO - Return code: 0 07:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:43 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:43 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:08:43 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:08:43 INFO - Using env: {'DISPLAY': ':0', 07:08:43 INFO - 'HOME': '/home/cltbld', 07:08:43 INFO - 'LANG': 'en_US.UTF-8', 07:08:43 INFO - 'LANGUAGE': 'en_US:en', 07:08:43 INFO - 'LOGNAME': 'cltbld', 07:08:43 INFO - 'MAIL': '/var/mail/cltbld', 07:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:43 INFO - 'MOZ_NO_REMOTE': '1', 07:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:43 INFO - 'NO_EM_RESTART': '1', 07:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:43 INFO - 'PWD': '/builds/slave/test', 07:08:43 INFO - 'SHELL': '/bin/bash', 07:08:43 INFO - 'SHLVL': '1', 07:08:43 INFO - 'TERM': 'linux', 07:08:43 INFO - 'TMOUT': '86400', 07:08:43 INFO - 'USER': 'cltbld', 07:08:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:43 INFO - '_': '/tools/buildbot/bin/python'} 07:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:43 INFO - Running setup.py (path:/tmp/pip-vZJgDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:43 INFO - Running setup.py (path:/tmp/pip-AHFhWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:43 INFO - Running setup.py (path:/tmp/pip-t2uV5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:43 INFO - Running setup.py (path:/tmp/pip-XlHtJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:43 INFO - Running setup.py (path:/tmp/pip-EpVfYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:43 INFO - Running setup.py (path:/tmp/pip-fMy3OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:43 INFO - Running setup.py (path:/tmp/pip-zZLoTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:43 INFO - Running setup.py (path:/tmp/pip-0OVmw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:44 INFO - Running setup.py (path:/tmp/pip-Q7t5oI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:44 INFO - Running setup.py (path:/tmp/pip-ELJPu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:44 INFO - Running setup.py (path:/tmp/pip-n_USzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:44 INFO - Running setup.py (path:/tmp/pip-Jux8va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:44 INFO - Running setup.py (path:/tmp/pip-xQWXR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:44 INFO - Running setup.py (path:/tmp/pip-T870VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:44 INFO - Running setup.py (path:/tmp/pip-rQaxS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:44 INFO - Running setup.py (path:/tmp/pip-pUvLbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:44 INFO - Running setup.py (path:/tmp/pip-vYhfDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:44 INFO - Running setup.py install for manifestparser 07:08:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:44 INFO - Running setup.py install for mozcrash 07:08:44 INFO - Running setup.py install for mozdebug 07:08:45 INFO - Running setup.py install for mozdevice 07:08:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for mozfile 07:08:45 INFO - Running setup.py install for mozhttpd 07:08:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for mozinfo 07:08:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for mozInstall 07:08:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for mozleak 07:08:45 INFO - Running setup.py install for mozlog 07:08:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for moznetwork 07:08:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:45 INFO - Running setup.py install for mozprocess 07:08:45 INFO - Running setup.py install for mozprofile 07:08:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:46 INFO - Running setup.py install for mozrunner 07:08:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:46 INFO - Running setup.py install for mozscreenshot 07:08:46 INFO - Running setup.py install for moztest 07:08:46 INFO - Running setup.py install for mozversion 07:08:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:46 INFO - Cleaning up... 07:08:46 INFO - Return code: 0 07:08:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:46 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:46 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:08:46 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:08:46 INFO - Using env: {'DISPLAY': ':0', 07:08:46 INFO - 'HOME': '/home/cltbld', 07:08:46 INFO - 'LANG': 'en_US.UTF-8', 07:08:46 INFO - 'LANGUAGE': 'en_US:en', 07:08:46 INFO - 'LOGNAME': 'cltbld', 07:08:46 INFO - 'MAIL': '/var/mail/cltbld', 07:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:46 INFO - 'MOZ_NO_REMOTE': '1', 07:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:46 INFO - 'NO_EM_RESTART': '1', 07:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:46 INFO - 'PWD': '/builds/slave/test', 07:08:46 INFO - 'SHELL': '/bin/bash', 07:08:46 INFO - 'SHLVL': '1', 07:08:46 INFO - 'TERM': 'linux', 07:08:46 INFO - 'TMOUT': '86400', 07:08:46 INFO - 'USER': 'cltbld', 07:08:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:46 INFO - '_': '/tools/buildbot/bin/python'} 07:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:46 INFO - Running setup.py (path:/tmp/pip-Jne5OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:46 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:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:46 INFO - Running setup.py (path:/tmp/pip-xU44Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:46 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:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:46 INFO - Running setup.py (path:/tmp/pip-GDPEJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:46 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:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:46 INFO - Running setup.py (path:/tmp/pip-dFc76b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:47 INFO - Running setup.py (path:/tmp/pip-9qhzP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:47 INFO - Running setup.py (path:/tmp/pip-HTHAN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:47 INFO - Running setup.py (path:/tmp/pip-gCwkTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:47 INFO - Running setup.py (path:/tmp/pip-7SkhWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:47 INFO - Running setup.py (path:/tmp/pip-vu7uok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:47 INFO - Running setup.py (path:/tmp/pip-AF1h8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:47 INFO - Running setup.py (path:/tmp/pip-UbHFGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:47 INFO - Running setup.py (path:/tmp/pip-Edwc_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:47 INFO - Running setup.py (path:/tmp/pip-1FAjac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:47 INFO - Running setup.py (path:/tmp/pip-OLK9A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:47 INFO - Running setup.py (path:/tmp/pip-vhYepS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:47 INFO - Running setup.py (path:/tmp/pip-0YtMnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:47 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:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:47 INFO - Running setup.py (path:/tmp/pip-XxU9nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:47 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:08:47 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:08:47 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:08:47 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:08:47 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:08:47 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:08:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08: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:08: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:08: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:08: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:08: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:08: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:08:49 INFO - Downloading blessings-1.6.tar.gz 07:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:49 INFO - Installing collected packages: blessings 07:08:49 INFO - Running setup.py install for blessings 07:08:50 INFO - Successfully installed blessings 07:08:50 INFO - Cleaning up... 07:08:50 INFO - Return code: 0 07:08:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:50 INFO - Reading from file tmpfile_stdout 07:08:50 INFO - Current package versions: 07:08:50 INFO - argparse == 1.2.1 07:08:50 INFO - blessings == 1.6 07:08:50 INFO - blobuploader == 1.2.4 07:08:50 INFO - docopt == 0.6.1 07:08:50 INFO - manifestparser == 1.1 07:08:50 INFO - mozInstall == 1.12 07:08:50 INFO - mozcrash == 0.17 07:08:50 INFO - mozdebug == 0.1 07:08:50 INFO - mozdevice == 0.48 07:08:50 INFO - mozfile == 1.2 07:08:50 INFO - mozhttpd == 0.7 07:08:50 INFO - mozinfo == 0.9 07:08:50 INFO - mozleak == 0.1 07:08:50 INFO - mozlog == 3.1 07:08:50 INFO - moznetwork == 0.27 07:08:50 INFO - mozprocess == 0.22 07:08:50 INFO - mozprofile == 0.28 07:08:50 INFO - mozrunner == 6.11 07:08:50 INFO - mozscreenshot == 0.1 07:08:50 INFO - mozsystemmonitor == 0.0 07:08:50 INFO - moztest == 0.7 07:08:50 INFO - mozversion == 1.4 07:08:50 INFO - psutil == 3.1.1 07:08:50 INFO - requests == 1.2.3 07:08:50 INFO - wsgiref == 0.1.2 07:08:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08: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:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:50 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:50 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:08:50 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:08:50 INFO - Using env: {'DISPLAY': ':0', 07:08:50 INFO - 'HOME': '/home/cltbld', 07:08:50 INFO - 'LANG': 'en_US.UTF-8', 07:08:50 INFO - 'LANGUAGE': 'en_US:en', 07:08:50 INFO - 'LOGNAME': 'cltbld', 07:08:50 INFO - 'MAIL': '/var/mail/cltbld', 07:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:50 INFO - 'MOZ_NO_REMOTE': '1', 07:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:50 INFO - 'NO_EM_RESTART': '1', 07:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:50 INFO - 'PWD': '/builds/slave/test', 07:08:50 INFO - 'SHELL': '/bin/bash', 07:08:50 INFO - 'SHLVL': '1', 07:08:50 INFO - 'TERM': 'linux', 07:08:50 INFO - 'TMOUT': '86400', 07:08:50 INFO - 'USER': 'cltbld', 07:08:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:50 INFO - '_': '/tools/buildbot/bin/python'} 07:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 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:08:50 INFO - Cleaning up... 07:08:50 INFO - Return code: 0 07:08:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08: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:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08: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', 'jsonschema'] in /builds/slave/test/build 07:08: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 jsonschema 07:08:50 INFO - Using env: {'DISPLAY': ':0', 07:08:50 INFO - 'HOME': '/home/cltbld', 07:08:50 INFO - 'LANG': 'en_US.UTF-8', 07:08:50 INFO - 'LANGUAGE': 'en_US:en', 07:08:50 INFO - 'LOGNAME': 'cltbld', 07:08:50 INFO - 'MAIL': '/var/mail/cltbld', 07:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:50 INFO - 'MOZ_NO_REMOTE': '1', 07:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:50 INFO - 'NO_EM_RESTART': '1', 07:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:50 INFO - 'PWD': '/builds/slave/test', 07:08:50 INFO - 'SHELL': '/bin/bash', 07:08:50 INFO - 'SHLVL': '1', 07:08:50 INFO - 'TERM': 'linux', 07:08:50 INFO - 'TMOUT': '86400', 07:08:50 INFO - 'USER': 'cltbld', 07:08:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:50 INFO - '_': '/tools/buildbot/bin/python'} 07:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:50 INFO - Downloading/unpacking jsonschema 07:08: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:08: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:08: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:08: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:08: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:08: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:08:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:08:52 INFO - Downloading/unpacking functools32 (from jsonschema) 07:08: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:08: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:08: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:08: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:08: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:08: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:08:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:08:52 INFO - warning: no files found matching '*.txt' 07:08:52 INFO - no previously-included directories found matching 'build' 07:08:52 INFO - no previously-included directories found matching 'dist' 07:08:52 INFO - no previously-included directories found matching '.git*' 07:08:52 INFO - Installing collected packages: jsonschema, functools32 07:08:53 INFO - Running setup.py install for functools32 07:08:53 INFO - warning: no files found matching '*.txt' 07:08:53 INFO - no previously-included directories found matching 'build' 07:08:53 INFO - no previously-included directories found matching 'dist' 07:08:53 INFO - no previously-included directories found matching '.git*' 07:08:53 INFO - Successfully installed jsonschema functools32 07:08:53 INFO - Cleaning up... 07:08:53 INFO - Return code: 0 07:08:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:08: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:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:53 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 0x7f0011998f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, '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': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', '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:08:53 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:08:53 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:08:53 INFO - Using env: {'DISPLAY': ':0', 07:08:53 INFO - 'HOME': '/home/cltbld', 07:08:53 INFO - 'LANG': 'en_US.UTF-8', 07:08:53 INFO - 'LANGUAGE': 'en_US:en', 07:08:53 INFO - 'LOGNAME': 'cltbld', 07:08:53 INFO - 'MAIL': '/var/mail/cltbld', 07:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:53 INFO - 'MOZ_NO_REMOTE': '1', 07:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:53 INFO - 'NO_EM_RESTART': '1', 07:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:53 INFO - 'PWD': '/builds/slave/test', 07:08:53 INFO - 'SHELL': '/bin/bash', 07:08:53 INFO - 'SHLVL': '1', 07:08:53 INFO - 'TERM': 'linux', 07:08:53 INFO - 'TMOUT': '86400', 07:08:53 INFO - 'USER': 'cltbld', 07:08:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:53 INFO - '_': '/tools/buildbot/bin/python'} 07:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:53 INFO - Downloading/unpacking flake8 07:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:08:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:08:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 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:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:55 INFO - no previously-included directories found matching 'docs/_build' 07:08:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:08:56 INFO - Running setup.py install for pep8 07:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:08:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:08:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:08:56 INFO - no previously-included directories found matching 'docs/_build' 07:08:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:08:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:08:56 INFO - Cleaning up... 07:08:56 INFO - Return code: 0 07:08:56 INFO - Running post-action listener: _resource_record_post_action 07:08:56 INFO - Running post-action listener: _start_resource_monitoring 07:08:56 INFO - Starting resource monitoring. 07:08:56 INFO - ##### 07:08:56 INFO - ##### Finished create-virtualenv step (success) 07:08:56 INFO - ##### 07:08:56 INFO - ##### 07:08:56 INFO - ##### Running install step. 07:08:56 INFO - ##### 07:08:56 INFO - Running pre-action listener: _resource_record_pre_action 07:08:56 INFO - Running main action method: install 07:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:56 INFO - Reading from file tmpfile_stdout 07:08:56 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:56 INFO - Reading from file tmpfile_stdout 07:08:56 INFO - Output received: 07:08:56 INFO - Usage: mozinstall [options] installer 07:08:56 INFO - Options: 07:08:56 INFO - -h, --help show this help message and exit 07:08:56 INFO - -d DEST, --destination=DEST 07:08:56 INFO - Directory to install application into. [default: 07:08:56 INFO - "/builds/slave/test"] 07:08:56 INFO - --app=APP Application being installed. [default: firefox] 07:08:56 INFO - mkdir: /builds/slave/test/build/application 07:08:56 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:08:56 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:09:13 INFO - Reading from file tmpfile_stdout 07:09:13 INFO - Output received: 07:09:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:13 INFO - Running post-action listener: _resource_record_post_action 07:09:13 INFO - ##### 07:09:13 INFO - ##### Finished install step (success) 07:09:13 INFO - ##### 07:09:13 INFO - ##### 07:09:13 INFO - ##### Running run-tests step. 07:09:13 INFO - ##### 07:09:13 INFO - Running pre-action listener: _resource_record_pre_action 07:09:13 INFO - Running main action method: run_tests 07:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:13 INFO - Python 2.7.3 07:09:13 INFO - Return code: 0 07:09:13 INFO - grabbing minidump binary from tooltool 07:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:13 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25679c0>, '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 0x25688c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2568d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:13 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:09:13 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:09:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:13 INFO - Return code: 0 07:09:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:14 INFO - Return code: 0 07:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:09:14 INFO - Using env: {'DISPLAY': ':0', 07:09:14 INFO - 'HOME': '/home/cltbld', 07:09:14 INFO - 'LANG': 'en_US.UTF-8', 07:09:14 INFO - 'LANGUAGE': 'en_US:en', 07:09:14 INFO - 'LOGNAME': 'cltbld', 07:09:14 INFO - 'MAIL': '/var/mail/cltbld', 07:09:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:14 INFO - 'MOZ_NO_REMOTE': '1', 07:09:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:14 INFO - 'NO_EM_RESTART': '1', 07:09:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:14 INFO - 'PWD': '/builds/slave/test', 07:09:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:14 INFO - 'SHELL': '/bin/bash', 07:09:14 INFO - 'SHLVL': '1', 07:09:14 INFO - 'TERM': 'linux', 07:09:14 INFO - 'TMOUT': '86400', 07:09:14 INFO - 'USER': 'cltbld', 07:09:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1462885214.974292-159627447', 07:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:14 INFO - '_': '/tools/buildbot/bin/python'} 07:09:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:09:14 INFO - mozversion application_buildid: 20160510043041 07:09:14 INFO - mozversion application_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 07:09:14 INFO - mozversion application_display_name: Nightly 07:09:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:14 INFO - mozversion application_name: Firefox 07:09:14 INFO - mozversion application_remotingname: firefox 07:09:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:09:14 INFO - mozversion application_vendor: Mozilla 07:09:14 INFO - mozversion application_version: 49.0a1 07:09:14 INFO - mozversion platform_buildid: 20160510043041 07:09:14 INFO - mozversion platform_changeset: 1579b9e2e50f3a27ad02d58cc9170c91e0973fec 07:09:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:09:14 INFO - mozversion platform_version: 49.0a1 07:09:14 INFO - using testdate: 1462889354 07:09:14 INFO - actual date: 1462889354 07:09:14 INFO - starting webserver on 'localhost:52148' 07:09:14 INFO - SUITE-START | Running 2 tests 07:09:14 INFO - TEST-START | dromaeo_css 07:09:14 INFO - operating with platform_type : linux_ 07:09:14 INFO - Initialising browser for dromaeo_css test... 07:09:14 INFO - TEST-INFO | started process 21121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNA5n9W/profile http://localhost:52148/getInfo.html) 07:09:18 INFO - PROCESS | 21121 | 07:09:18 INFO - PROCESS | 21121 | (process:21193): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:09:19 INFO - PROCESS | 21121 | __metrics Screen width/height:1600/1200 07:09:19 INFO - PROCESS | 21121 | colorDepth:24 07:09:19 INFO - PROCESS | 21121 | Browser inner width/height: 1024/697 07:09:19 INFO - PROCESS | 21121 | __metrics 07:09:20 ERROR - PROCESS | 21121 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:09:21 INFO - TEST-INFO | 21121: exit 0 07:09:21 INFO - Browser initialized. 07:09:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:21 INFO - TEST-INFO | started process 21244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNA5n9W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:22 INFO - PROCESS | 21244 | 07:09:22 INFO - PROCESS | 21244 | (process:21304): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:09:32 INFO - PROCESS | 21244 | RSS: Main: 163303424 07:09:32 INFO - PROCESS | 21244 | 07:10:22 INFO - PROCESS | 21244 | 1462889422444 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:12:30 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52148/tests/dromaeo/cssquery-ext.html) 07:12:31 INFO - PROCESS | 21244 | RSS: Main: 166191104 07:12:31 INFO - PROCESS | 21244 | 07:15:33 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-ext.html (next: http://localhost:52148/tests/dromaeo/cssquery-jquery.html) 07:15:33 INFO - PROCESS | 21244 | RSS: Main: 165441536 07:15:33 INFO - PROCESS | 21244 | 07:18:35 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52148/tests/dromaeo/cssquery-mootools.html) 07:18:36 INFO - PROCESS | 21244 | RSS: Main: 166780928 07:18:36 INFO - PROCESS | 21244 | 07:21:38 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52148/tests/dromaeo/cssquery-prototype.html) 07:21:38 INFO - PROCESS | 21244 | RSS: Main: 164544512 07:21:38 INFO - PROCESS | 21244 | 07:24:41 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52148/tests/dromaeo/cssquery-yui.html) 07:24:41 INFO - PROCESS | 21244 | RSS: Main: 165384192 07:24:41 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | Cycle 1(1): loaded http://localhost:52148/tests/dromaeo/cssquery-yui.html (next: http://localhost:52148/tests/dromaeo/cssquery-dojo.html) 07:27:44 INFO - PROCESS | 21244 | RSS: Main: 167755776 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | __start_tp_report 07:27:44 INFO - PROCESS | 21244 | _x_x_mozilla_page_load 07:27:44 INFO - PROCESS | 21244 | _x_x_mozilla_page_load_details 07:27:44 INFO - PROCESS | 21244 | |i|pagename|runs| 07:27:44 INFO - PROCESS | 21244 | |0;dojo.html;3152.369526094781;3171.4767063434533;3232.0303908827345;3237.4820028795384;3240.1089700332413;5418.593605479595;5447.645903016306;5453.427390124039;5529.060059789836;5529.391766905637;5346.679199248048;5405.162199859028;5442.455754424555;5464.316960379952;5553.250311207996;4860.611151107921;4907.2884431757375;5026.874328141789;5060.633628920189;5124.564412024983;910.5541503793978;4848.17581011229;4883.438404583465;4958;4965.155923493015;4955.98402327522;4962.206047032458;4991.700497970097;4997.100521906055;5008.924866127011;5014.52362025607;5017.448080711119;5024.924626130574;5035.672681275705;5086.41506226785;4891.608671306322;4906.582940450066;4960.206366981266;4972.701637901738;4981.476944920803;5369.919451208235;5414.10667239905;5434.212039254286;5444.455554444564;5469.617126801126;5619;5823.737931793079;5828.5628577856405;5847.473727364558;5858.912116318259;5933.436323549256;5989.91015134769;6008.24896887889;6029.065494848305;6064.272287325549;5580.804671836507;5585.720713964285;5586.748596313135;5602.551795856321;5607.130894711327;5853.970730146322;5944.613600115978;5992.191054207713;6100.572959892765;6115.205023346936;5652.349979752381;5660.037793575102;5688.203651488795;5688.345840228344;5706.115552089433;5780.94219057804;5807.738651760681;5834.591578589543;5836.970815145897;5838.357780644125;5749.54003679713;5768.423157684198;5804.1293805929445;5825.475707186373;5827.970860145672;5777.711114444261;5808.332041815161;5836.328822185418;5855.355910849803;5862.267216597926;4326.134773045404;4404.977975110104;4442.733435993786;4461.420015398043;4483.887902802391;3887.1642596841816;3944.5069366329208;3959.8614048508166;3990.38149086892;4006.0786019215743;5510;5519.31008623922;5558.916616250759;5612.550995920316;5627.240322556484;5832.679202643895;5853.795117170964;5874.823755287348;5878.853028674317;5881.647101173858;5417.214503896913;5527.39198688144;5553.083741182741;5570.610057296031;5605.0751625982075;5070.442251352349;5081.872953176126;5085.415177254663;5095.592352611782;5109.20807274873;6059.21230240066;6071.939280607137;6091.725872335755;6092.817215483543;6112.510999120149;5682.289713785777;5748.568857335633;5879.265091863432;5881.676507792113;5926.555508336978;6090.908636370546;6125.99826085224;6128.8774224516155;6129.756146212572;6155.599886007395;5833.445822646841;5842.883142337215;5847.210626565359;5868.5305175585;5873.442023007808;5673.9432605675065;5858.7110835616095;5907.261592300963;5909.23179986599;5973.193618861398;5744.798932037525;5767.365589785037;5796.971015144897;5826.096954971986;5826.242588463472;5773.24947756789;5792;5803.332616749128;5831.1544826000845;5834.18321435008;5505.889882202414;5609.663420194638;5612.943870561406;5644.9435505644415;5675.631083979528;5783.219265399117;5795.971020144872;5827.621204621686;5828.533717302521;5844.298684157929;5668.51817595509;5672.177534257592;5681.744321505625;5683.8010669626365;5686.09022556389 07:27:44 INFO - PROCESS | 21244 | |1;ext.html;583.4981915552627;622.3745136138181;642.9260635026973;646.4569761400422;646.8350570604496;43064.78467607661;44301.556984430186;44652.3302150468;44756.55243447565;48500;43590;43962.34056489155;44147.77926110373;44166.558334416644;44198.77900610492;8939.642414303436;8984.730458086267;8986;9014.639414423415;9046.457212567235;8758.343124265673;8780.560971951378;8839;8839.73480795574;8954.2836573074;8935.776605584848;8999.28005759541;9019.2784577234;9021.819563608724;9031.367804253705;8902.554872256362;8935.32985026119;8936.151065648754;8943.77640558988;9008.77478063047;8700.956495217546;8763.824723505559;8768.605412756442;8823.647054117828;8833.425827321204;42716.572834271574;43059.784701076605;43144.78427607873;43172.784136079434;43288.78355608233;3419.606745224306;3425.4519276915576;3558.1282585766394;3639.5632524097014;3860.4209368594934;32511.674883251337;32565.83717081423;32882.50676239858;33223.16942076443;33397.6660233397;4353.825846966118;4377.277749171383;4380.693351465398;4386.71486353386;4426.358178064195;236352;311654;313390;313542;313711.99999999773;59524.55943007124;60277.69861150754;60548;60732;60791.39208607946;36603.4509482358;37758.244835103695;37872.43191352132;39835.00412489653;39843;16011.519654410386;16080.195990200444;16181.4336498222;16194.43319483836;16224.269907854175;12581.559645412366;12672.556460523838;12709.300988445724;12766.489340426464;12777.16948398351;19713.211471541264;20180.192792288144;20196.495087622632;20334;20374.79625203729;7431.591262480615;7529.510581812165;7529.623518824037;7556;7671.424643151786;964.4020707161604;1035.6634093919356;1086.326477583903;1112.477135746198;1170.3270619393882;32355;32629.67370326314;32765;32810.67189328076;33151.171220719196;1163.3310846263264;1184.4729095552568;1186.400867561893;1226.4910062324213;1269.1306455078302;16873.746893796604;17317.4804755855;17337.739933901;17497.825021749875;17599.824001760073;457595;459822;460370;461037;461368;58991;59393;59858.401415986154;60347.69826150841;60427.69786151041;1382.67507135823;1386.909850859711;1410.9576712698636;1416.355558221007;1423.800667906494;30971.070867874;30973.69026309708;31539.36921261516;32099.839500802347;32272.83863580667;50988;51033;51368.48631513637;51412;51488.48511514837;375634;379627;379840;380794;382176;28342.149735507966;28425.147245582666;28498;28555.857220713762;28596.571051433828;46886.29670554876;48391;49446.50553494419;51231;51743.22385164301;42123;42799.35800962926;42952.57047429486;42980.57019429766;44074.77962610166;40432.79783601181;40979.795101024305;41851.372229415974;41971.16057678768;43152.35271470868;42821;43032;43741.78129109334;44048.11903761971;45940.77029614831;36721.63278367289;37332.81333593315;37580;37678.62321376861;38006.42990355092;28319.716802831706;28736.137915862557;28757.42485150327;29205.269868253465;29230.853845731486 07:27:44 INFO - PROCESS | 21244 | |2;jquery.html;407.2750504102696;407.3482428115016;408.72615347717027;410.09369293860567;422.9767362795047;17560.385386511476;18705.25178992842;19113.426597202073;19209.423717288468;19499.805001949975;18828.152733127008;18854.057297135158;19084;19718;19747.70378444321;5493.423190564993;5510.201020851974;5758.337791154029;5759.740811663485;5771.3074431068335;5646.096624540074;5681;5686.943130568683;5687.630304030225;5712.0860662293835;5470.671759694411;5596.804111856066;5627.043402621564;5654.123610840326;5683.2895888014;5422.864428389283;5638.774449022055;5652.265205523277;5662.122371032456;5673.205751194836;5009.949900500985;5014.348134742497;5077.593792496628;5108.897822043538;5118.744062796883;16705.081220532866;19220.519487012796;22106.557868842534;22315.888420557956;22369;2360.268316821791;2392.2583998960376;2428.3200703802963;2568.9229323120335;2742.657167854018;14445.133292002514;14805.629859253497;14876;14929.253537323091;15059.247037648183;1944.6013567218827;2026.9189232430685;2043.5402034542258;2055.4758536573227;2106.73665791776;77204.22795772027;80716.19283807205;81241;81901.18098818995;82032;10272.33229840058;10380.532876020598;10781.676549703521;10803.675889723321;10871.619493317696;15234.619134521725;15325;15333.539993800205;15336.539903802905;15361.846381536265;7737.922620773833;7808.414368922354;7850.371970242367;7871.685132594632;8011.679532818622;7163.641817909083;7179.174394944648;7179.856402871913;7538.698452061966;7540.208278130827;6516.869662606721;6614.669266536654;6672.666366681647;6677.662818013657;6705.228898676714;1925.6341295153875;1963.4306051244978;1966.7639883214106;1982.8413726901813;2018.7880272571463;978.5449765858909;1059.5580553643883;1064.9787004259872;1093.868735751715;1095.884932082136;17538.386156484463;19026.61946761057;19319.13063912099;19338.226470941285;19630.502243984116;1084.446932064637;1085.9239853210358;1105.5854054729477;1170.9941450292695;1192.934388608635;10951.671449856518;11035.724106897393;11164.832527512093;11243.60647377338;11246.831297530543;460304;466657;467825;498776;504145;55155.44844551503;71702;73076.63461682764;77354.6132269335;80076.19923800687;1087.896649818266;1098.7088421568292;1119.4906317625462;1119.6417146513038;1135.949246946571;17391;17583;17721.55696107556;17769.73345399846;17974.91012544929;36888.61405888403;37228.813855930544;38463.423048653734;38522.6147738519;39381.2123757529;49365.25952110793;50086;50357;50627.746861265456;50677.74661126671;8765;8770.12298770118;8855.867161992446;9012.233960113464;9049.457032578066;12197.573084941985;13359.933200333937;13396.93301533486;14004.089734167246;14241.430342786587;11743.706407339885;11844.348560829238;11985.940070299594;12080.308756773882;12129.272243665408;11753.941230293794;12023.699407514881;12065.276083435023;12170.330631815335;12223.449944752685;12099.153059285765;12161.087918405978;12193.57322493744;12211.816822747489;12356.3821808911;8946;9172.312076594415;9173.312001599774;9265.212456941235;9381.296402769956;11637.127215458706;11969.820452693042;12019.338936358585;12122.636320910387;12191.939040304742 07:27:44 INFO - PROCESS | 21244 | |3;mootools.html;1441.6540030392703;1509.2076659753627;1622.2537632688961;1853.620007898381;1854.3046357615901;7882.172371900954;8257.380696447768;8313.376496762738;8869.68956086537;8899.95550022249;8525.062243153248;8694;8740.737777866658;8779.824403511926;8792.560371981392;2333.4516388648694;2362.822788290885;2363.3382652857226;2367.95264094718;2367.981767839828;2296.977030229693;2326.8487548309304;2369.668246445499;2378.322178179211;2379.7858192762646;2290.7365652949875;2307.0541078157958;2314.4445333120016;2314.872682002489;2333.4866329407505;2292.3466811958597;2317.9884100579557;2322.1524143687516;2323.3146221864504;2343.367290831466;2269.5687819314444;2297.5979203639463;2304.7349554801076;2308.0652335804025;2314.0281081945623;8767.956160219223;8834.425762325429;8903;8906.643734250621;8921.286297096216;5176.0683077046115;5296.285001524783;5304.177852432879;5344.732763361816;5362.973185134088;3278.49183376577;3292.0946739646547;3437.364087643769;3490.703290220334;3510.350585141757;1121.2151493954264;1128.3230061962756;1140.4639819284923;1147.0192984997873;1178.298912147271;11810.350430726221;11833.526658933632;11949.342786146759;11955.342456164908;11984.880151198464;4581.518940511265;4587.564181402761;4758.262469317261;4802.783874725646;4819.903601928012;9804.558794854249;9883.950580247052;9932.106110450095;9939.353941993748;9950.751231219132;5296.576273898079;5310.707911064851;5312.389075256395;5316.601254905898;5328.493793089728;4243.151369726067;4870.439899411542;4916.434610019894;4957.405111386656;5017.272495488134;3742.288965096677;3770.3967365221433;3836.2327534492656;3845.750026248341;3849.0569810396632;1162.3026184289358;1167.229628445222;1167.96496105117;1175.1538891997748;1185.4191446191476;987.6740675577042;1022.8772547294373;1041.510490069666;1048.046277887119;1082.5886163257912;6019.337872833985;6286.5599408041;6329.778457753957;6332.176817013851;6443.097966284724;425.2642927735036;433.87417648882104;437.8970941828668;446.30599417905466;459.7195710616521;4255.1915136124035;4345.500267469281;4371.0820727646915;4431.40176076232;4466.575675310905;10737.946310268555;11065.778684426266;11077.556897724162;11120.165987550967;11160.0513956313;10702.357858528514;10737.624183153552;10954.835677464844;10960.890391096147;11071.391073491035;8222.17778222185;8262.215089566362;8318.958405207935;8328.417010809186;8431.114732953074;5895.4399332063385;5985.371535988833;6025.1564780931585;6308.621482711052;6353.396427339396;9937.602495900082;10009.749756256151;10052.849207262043;10104.04011618895;10158.847617285599;10218.233632477446;10323.94838025835;10413.84379234297;10554.525046373084;10631.617889674293;7219.819504512429;7626.504277221963;7783.805404864924;7847.450678452454;7993.6003199838615;8727.869081963649;8737.169968852948;8743.256823170103;8807.427517211361;8898.510581918057;7686.231376862493;7819.374450044096;7928.7621371358955;7934.404919630935;7944.880826787487;7657.4256930731535;7745.341645960157;7817.882731758915;7829.686812527435;7942.483738556975;7334.486585938933;7336.339729424378;7364.852702946018;7403.185649578434;7406.407487401103;5573.860653483695;5601.355844077821;5610.579206559606;5659.151127330769;5689.800856969986;5372.301600791872;5409;5469.699166545719;5517.089680202722;5556.555475562026 07:27:44 INFO - PROCESS | 21244 | |4;prototype.html;330.5554029829878;348.46684572603914;348.93021395720854;351.6501081423983;355.486322264328;5468.343798744151;5645.830625081254;5647.701028763387;5674.574406919477;5678.829635110953;5541;5550.306211723535;5551.555875529958;5563.972180139103;5577.772889964202;4091;4374.803133858984;4392.450943632046;4409.250427427345;4421.425214722081;3965.246603145408;4313.525512193656;4317.740935543861;4330.740155590659;4347.391365208873;4328.4156638853665;4344.826206951734;4357.324614684729;4364.563543645641;4378.693491455583;4307.719998200123;4323.329883868006;4342.5874541918465;4374.34384842273;4374.4531933508315;3577.123604716835;3767.9434808477895;3772.000419888732;3791.50710407648;3878.3600705883496;5399.406065332811;5423.457654234545;5434.755436005389;5443.755031023574;5453.890922181574;4932.408111026664;4975.3532040834825;4981.526754958273;4999.250112483121;5039.420466646346;5609.523190528769;5889.646621202742;5890.582063452411;5913.586048976574;5922.3485416604135;4183.1215444756635;4189.601987811153;4195.580441955811;4220.556841531657;4241.2365774160635;5794.913076303858;5841.912371314434;6171.382861713838;6198.566100372976;6224.719887605069;4170.562090980464;4232.555581663943;4248.787560621957;4249.830006799693;4282.250606143913;4284.365115453973;4326.610605045561;4344.630706389929;4350.260455722535;4355.932796464823;4828.444728856156;4901.044296362175;4977.502249774993;4992.875178120504;5004.799808007639;5879;5894;5896.115582662635;5918.129707092057;5918.201042859159;1467.7358075546504;1477.7044591081826;1481.3482067890309;1499.212913220568;1506.3823832228734;925.4308600210821;945.385499425379;956.4266781144978;959.5873774276988;970.4904924914476;5021.372328458942;5021.723805190676;5028.974855125701;5031.566003689004;5035.949640503622;5222.328854766438;5255.710935898563;5349.522810173418;5367.812126575551;5372.435894231127;5061.544460998528;5068.315777370081;5100.234964755242;5282.524572788468;5787.276590426197;3232.6767323267486;3272.9672703272663;3273.0344548358294;3284.4088064148204;3288.9475367882046;6058.303295121029;6252.406021427957;6262.4990000800735;6277.52918531112;6352.872942541123;6210.782622608187;6214.751409943552;6218.129461875341;6231.189945307081;6233.594816337014;6280.591761535486;6309.968450157719;6314.810555683337;6324.08300796382;6338.397852204033;5795.913061304;6038.456538911519;6054.215061071956;6091.177691011834;6096.390360964046;6028.819135425944;6029.336772955059;6044.546659000681;6052.243469566304;6064.545159112996;5978.880422391615;6070.271567411939;6239.594426362272;6242.843928901632;6312.905306420499;4270.188664153801;4279.716085174373;4280.871573852789;4295.968967447852;4298.806553705028;5848.970755146197;5997.16039754426;6024.487918526975;6025.849353766191;6073.210482637405;5765.019946609003;5806.68063256525;5836.649801011953;5848.444397782204;5879;5849.766009359748;5866.530677545871;5904.675242861684;5912.379200184091;5916.201312822886;5639.943600563942;5686.289213848269;5822.94177058241;5864.237649105759;5864.44287792659;5887.293524777054;5949.382271800394;5970.507373156711;6026.186464827192;6044.304904935812;5464.590155738256;5767.452092051416;5813.476787089182;5839.941600583939;5873.678422354936 07:27:44 INFO - PROCESS | 21244 | |5;yui.html;723.75754122369;745.0463406839248;747.7868807389895;748.5284270909328;763.713607397226;13710.794338084925;14348.569542913703;14452.06061605995;14583.270836458174;14589.343479543419;14093.647658808535;14147.504837330696;14148.646283842909;14169;14190.21953792541;678.7861823525586;797.0037453183521;817.0767033252416;820.7004443378183;822.284612387224;809.5587904591982;811.9837603247931;819.5001049359886;820.2248874813304;823.0822632764455;865.1996902864856;866.5667166416791;868.68727258187;869.74342568942;873.9825203495926;863.4732812984074;871.5511511571545;871.7254064969546;871.960761765722;873.1792115411524;635.034747184282;635.3043417457876;635.71710588788;635.7393468677866;636.936306369364;14058.789118163235;14288.857111428857;14305.427782888672;14344.13935163883;14408.495702650462;14277.143371397646;14415.567532974028;14527.346269417796;14591.54084591543;14723.705525889422;11363.545458181663;11524;11569.016633586156;11617.302961822234;11784.410779460992;3856.730028897978;3872.1094148345755;3981.900452488682;4042.43405923171;4050.51393832739;53734.731326343506;54199.45800541984;54272.72863635696;54359.72820135874;54741;10479.633212837514;10548.630797922036;10645.095166910745;10693.786124277627;10731.302465339728;20510.487237818874;20824.47938801542;20855.58288834215;20887.164513419597;20888;8185.467944583583;8212.8357432851;8228.25945664893;8266.297364723945;8398.118197589287;4642.37327960721;4674.298855171752;4706.623470122382;4787.8563643090765;4825.9034819303415;3333.3666603345287;3433;3453.723702103826;3456.1532424556144;3457.740669449751;653.1574269192784;679.0730652659084;701.9894701579481;704.2183176673888;711.8425618400873;790.675822912603;809.554744890308;814.9511029338258;829.6971605363999;833.5332213960202;9708.708738737849;9909.65316213929;9996.150327222267;10041.748956276151;10238.692839214835;731.042334541752;763.6181909045478;781.2695130053419;796.8047828282108;799.8960135182506;4846.733429661403;4926.531979462017;4970.850874473772;4972.477889821516;4990.2764099205415;52096.73951630218;53243;54077;65831;67930.3206967924;54666.45333546693;55625.721871390386;55642.44357556454;56344.43655563474;57247;51389.486105139214;51856.740716296175;51881;51910.74044629828;53159.73420132952;9448.338616297067;9519.095685909828;9612.615495380107;9649.565769540248;9652.951735241279;33151;34311.82844085764;34613.65386346104;35056.59773609027;35104.648953510135;45656;46076.30885536653;46179.53820461752;46542.767286163355;47001;12367.876321236672;12553.701891796629;12723.872761272269;12759.362031898554;12835.871641283467;13550.93224533871;13734.725305494034;14067.577972660836;14405.711885762435;14758;13003;13096.672583185496;13210.867891320964;13210.933945330213;13389.464421423034;10647.094996925349;11331.546738130382;11418.371989540656;11564;12673;11839.408029598659;11846.289222646668;12262.26426414418;12481.875181248435;12672.936635316764;9907;9907.356021858555;9931.106200441705;9938.503074846085;9956.900430995598;10402.115820155372;10582.788344233226;10628.149748020294;10691.679249622213;10692.19808514349 07:27:44 INFO - PROCESS | 21244 | __end_tp_report 07:27:44 INFO - PROCESS | 21244 | __start_cc_report 07:27:44 INFO - PROCESS | 21244 | _x_x_mozilla_cycle_collect,332 07:27:44 INFO - PROCESS | 21244 | __end_cc_report 07:27:44 INFO - PROCESS | 21244 | __startTimestamp1462890464421__endTimestamp 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | ------- Summary: start ------- 07:27:44 INFO - PROCESS | 21244 | Number of tests: 6 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#0] dojo.html Cycles:165 Average:5425.12 Median:5672.18 stddev:717.76 (12.7%) stddev-sans-first:697.46 07:27:44 INFO - PROCESS | 21244 | Values: 3152.4 3171.5 3232.0 3237.5 3240.1 5418.6 5447.6 5453.4 5529.1 5529.4 5346.7 5405.2 5442.5 5464.3 5553.3 4860.6 4907.3 5026.9 5060.6 5124.6 910.6 4848.2 4883.4 4958.0 4965.2 4956.0 4962.2 4991.7 4997.1 5008.9 5014.5 5017.4 5024.9 5035.7 5086.4 4891.6 4906.6 4960.2 4972.7 4981.5 5369.9 5414.1 5434.2 5444.5 5469.6 5619.0 5823.7 5828.6 5847.5 5858.9 5933.4 5989.9 6008.2 6029.1 6064.3 5580.8 5585.7 5586.7 5602.6 5607.1 5854.0 5944.6 5992.2 6100.6 6115.2 5652.3 5660.0 5688.2 5688.3 5706.1 5780.9 5807.7 5834.6 5837.0 5838.4 5749.5 5768.4 5804.1 5825.5 5828.0 5777.7 5808.3 5836.3 5855.4 5862.3 4326.1 4405.0 4442.7 4461.4 4483.9 3887.2 3944.5 3959.9 3990.4 4006.1 5510.0 5519.3 5558.9 5612.6 5627.2 5832.7 5853.8 5874.8 5878.9 5881.6 5417.2 5527.4 5553.1 5570.6 5605.1 5070.4 5081.9 5085.4 5095.6 5109.2 6059.2 6071.9 6091.7 6092.8 6112.5 5682.3 5748.6 5879.3 5881.7 5926.6 6090.9 6126.0 6128.9 6129.8 6155.6 5833.4 5842.9 5847.2 5868.5 5873.4 5673.9 5858.7 5907.3 5909.2 5973.2 5744.8 5767.4 5797.0 5826.1 5826.2 5773.2 5792.0 5803.3 5831.2 5834.2 5505.9 5609.7 5612.9 5644.9 5675.6 5783.2 5796.0 5827.6 5828.5 5844.3 5668.5 5672.2 5681.7 5683.8 5686.1 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#1] ext.html Cycles:180 Average:55005.36 Median:42810.18 stddev:101573.74 (237.3%) stddev-sans-first:101776.50 07:27:44 INFO - PROCESS | 21244 | Values: 583.5 622.4 642.9 646.5 646.8 43064.8 44301.6 44652.3 44756.6 48500.0 43590.0 43962.3 44147.8 44166.6 44198.8 8939.6 8984.7 8986.0 9014.6 9046.5 8758.3 8780.6 8839.0 8839.7 8954.3 8935.8 8999.3 9019.3 9021.8 9031.4 8902.6 8935.3 8936.2 8943.8 9008.8 8701.0 8763.8 8768.6 8823.6 8833.4 42716.6 43059.8 43144.8 43172.8 43288.8 3419.6 3425.5 3558.1 3639.6 3860.4 32511.7 32565.8 32882.5 33223.2 33397.7 4353.8 4377.3 4380.7 4386.7 4426.4 236352.0 311654.0 313390.0 313542.0 313712.0 59524.6 60277.7 60548.0 60732.0 60791.4 36603.5 37758.2 37872.4 39835.0 39843.0 16011.5 16080.2 16181.4 16194.4 16224.3 12581.6 12672.6 12709.3 12766.5 12777.2 19713.2 20180.2 20196.5 20334.0 20374.8 7431.6 7529.5 7529.6 7556.0 7671.4 964.4 1035.7 1086.3 1112.5 1170.3 32355.0 32629.7 32765.0 32810.7 33151.2 1163.3 1184.5 1186.4 1226.5 1269.1 16873.7 17317.5 17337.7 17497.8 17599.8 457595.0 459822.0 460370.0 461037.0 461368.0 58991.0 59393.0 59858.4 60347.7 60427.7 1382.7 1386.9 1411.0 1416.4 1423.8 30971.1 30973.7 31539.4 32099.8 32272.8 50988.0 51033.0 51368.5 51412.0 51488.5 375634.0 379627.0 379840.0 380794.0 382176.0 28342.1 28425.1 28498.0 28555.9 28596.6 46886.3 48391.0 49446.5 51231.0 51743.2 42123.0 42799.4 42952.6 42980.6 44074.8 40432.8 40979.8 41851.4 41971.2 43152.4 42821.0 43032.0 43741.8 44048.1 45940.8 36721.6 37332.8 37580.0 37678.6 38006.4 28319.7 28736.1 28757.4 29205.3 29230.9 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#2] jquery.html Cycles:180 Average:27957.74 Median:12106.65 stddev:78673.48 (649.8%) stddev-sans-first:78866.98 07:27:44 INFO - PROCESS | 21244 | Values: 407.3 407.3 408.7 410.1 423.0 17560.4 18705.3 19113.4 19209.4 19499.8 18828.2 18854.1 19084.0 19718.0 19747.7 5493.4 5510.2 5758.3 5759.7 5771.3 5646.1 5681.0 5686.9 5687.6 5712.1 5470.7 5596.8 5627.0 5654.1 5683.3 5422.9 5638.8 5652.3 5662.1 5673.2 5009.9 5014.3 5077.6 5108.9 5118.7 16705.1 19220.5 22106.6 22315.9 22369.0 2360.3 2392.3 2428.3 2568.9 2742.7 14445.1 14805.6 14876.0 14929.3 15059.2 1944.6 2026.9 2043.5 2055.5 2106.7 77204.2 80716.2 81241.0 81901.2 82032.0 10272.3 10380.5 10781.7 10803.7 10871.6 15234.6 15325.0 15333.5 15336.5 15361.8 7737.9 7808.4 7850.4 7871.7 8011.7 7163.6 7179.2 7179.9 7538.7 7540.2 6516.9 6614.7 6672.7 6677.7 6705.2 1925.6 1963.4 1966.8 1982.8 2018.8 978.5 1059.6 1065.0 1093.9 1095.9 17538.4 19026.6 19319.1 19338.2 19630.5 1084.4 1085.9 1105.6 1171.0 1192.9 10951.7 11035.7 11164.8 11243.6 11246.8 460304.0 466657.0 467825.0 498776.0 504145.0 55155.4 71702.0 73076.6 77354.6 80076.2 1087.9 1098.7 1119.5 1119.6 1135.9 17391.0 17583.0 17721.6 17769.7 17974.9 36888.6 37228.8 38463.4 38522.6 39381.2 49365.3 50086.0 50357.0 50627.7 50677.7 8765.0 8770.1 8855.9 9012.2 9049.5 12197.6 13359.9 13396.9 14004.1 14241.4 11743.7 11844.3 11985.9 12080.3 12129.3 11753.9 12023.7 12065.3 12170.3 12223.4 12099.2 12161.1 12193.6 12211.8 12356.4 8946.0 9172.3 9173.3 9265.2 9381.3 11637.1 11969.8 12019.3 12122.6 12191.9 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#3] mootools.html Cycles:180 Average:5842.40 Median:2608.99 stddev:3294.53 (126.3%) stddev-sans-first:3287.17 07:27:44 INFO - PROCESS | 21244 | Values: 1441.7 1509.2 1622.3 1853.6 1854.3 7882.2 8257.4 8313.4 8869.7 8900.0 8525.1 8694.0 8740.7 8779.8 8792.6 2333.5 2362.8 2363.3 2368.0 2368.0 2297.0 2326.8 2369.7 2378.3 2379.8 2290.7 2307.1 2314.4 2314.9 2333.5 2292.3 2318.0 2322.2 2323.3 2343.4 2269.6 2297.6 2304.7 2308.1 2314.0 8768.0 8834.4 8903.0 8906.6 8921.3 5176.1 5296.3 5304.2 5344.7 5363.0 3278.5 3292.1 3437.4 3490.7 3510.4 1121.2 1128.3 1140.5 1147.0 1178.3 11810.4 11833.5 11949.3 11955.3 11984.9 4581.5 4587.6 4758.3 4802.8 4819.9 9804.6 9884.0 9932.1 9939.4 9950.8 5296.6 5310.7 5312.4 5316.6 5328.5 4243.2 4870.4 4916.4 4957.4 5017.3 3742.3 3770.4 3836.2 3845.8 3849.1 1162.3 1167.2 1168.0 1175.2 1185.4 987.7 1022.9 1041.5 1048.0 1082.6 6019.3 6286.6 6329.8 6332.2 6443.1 425.3 433.9 437.9 446.3 459.7 4255.2 4345.5 4371.1 4431.4 4466.6 10737.9 11065.8 11077.6 11120.2 11160.1 10702.4 10737.6 10954.8 10960.9 11071.4 8222.2 8262.2 8319.0 8328.4 8431.1 5895.4 5985.4 6025.2 6308.6 6353.4 9937.6 10009.7 10052.8 10104.0 10158.8 10218.2 10323.9 10413.8 10554.5 10631.6 7219.8 7626.5 7783.8 7847.5 7993.6 8727.9 8737.2 8743.3 8807.4 8898.5 7686.2 7819.4 7928.8 7934.4 7944.9 7657.4 7745.3 7817.9 7829.7 7942.5 7334.5 7336.3 7364.9 7403.2 7406.4 5573.9 5601.4 5610.6 5659.2 5689.8 5372.3 5409.0 5469.7 5517.1 5556.6 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#4] prototype.html Cycles:180 Average:4897.62 Median:5504.67 stddev:1450.56 (26.4%) stddev-sans-first:1413.55 07:27:44 INFO - PROCESS | 21244 | Values: 330.6 348.5 348.9 351.7 355.5 5468.3 5645.8 5647.7 5674.6 5678.8 5541.0 5550.3 5551.6 5564.0 5577.8 4091.0 4374.8 4392.5 4409.3 4421.4 3965.2 4313.5 4317.7 4330.7 4347.4 4328.4 4344.8 4357.3 4364.6 4378.7 4307.7 4323.3 4342.6 4374.3 4374.5 3577.1 3767.9 3772.0 3791.5 3878.4 5399.4 5423.5 5434.8 5443.8 5453.9 4932.4 4975.4 4981.5 4999.3 5039.4 5609.5 5889.6 5890.6 5913.6 5922.3 4183.1 4189.6 4195.6 4220.6 4241.2 5794.9 5841.9 6171.4 6198.6 6224.7 4170.6 4232.6 4248.8 4249.8 4282.3 4284.4 4326.6 4344.6 4350.3 4355.9 4828.4 4901.0 4977.5 4992.9 5004.8 5879.0 5894.0 5896.1 5918.1 5918.2 1467.7 1477.7 1481.3 1499.2 1506.4 925.4 945.4 956.4 959.6 970.5 5021.4 5021.7 5029.0 5031.6 5035.9 5222.3 5255.7 5349.5 5367.8 5372.4 5061.5 5068.3 5100.2 5282.5 5787.3 3232.7 3273.0 3273.0 3284.4 3288.9 6058.3 6252.4 6262.5 6277.5 6352.9 6210.8 6214.8 6218.1 6231.2 6233.6 6280.6 6310.0 6314.8 6324.1 6338.4 5795.9 6038.5 6054.2 6091.2 6096.4 6028.8 6029.3 6044.5 6052.2 6064.5 5978.9 6070.3 6239.6 6242.8 6312.9 4270.2 4279.7 4280.9 4296.0 4298.8 5849.0 5997.2 6024.5 6025.8 6073.2 5765.0 5806.7 5836.6 5848.4 5879.0 5849.8 5866.5 5904.7 5912.4 5916.2 5639.9 5686.3 5822.9 5864.2 5864.4 5887.3 5949.4 5970.5 6026.2 6044.3 5464.6 5767.5 5813.5 5839.9 5873.7 07:27:44 INFO - PROCESS | 21244 | 07:27:44 INFO - PROCESS | 21244 | [#5] yui.html Cycles:180 Average:14942.32 Median:4806.88 stddev:17061.26 (354.9%) stddev-sans-first:17075.70 07:27:44 INFO - PROCESS | 21244 | Values: 723.8 745.0 747.8 748.5 763.7 13710.8 14348.6 14452.1 14583.3 14589.3 14093.6 14147.5 14148.6 14169.0 14190.2 678.8 797.0 817.1 820.7 822.3 809.6 812.0 819.5 820.2 823.1 865.2 866.6 868.7 869.7 874.0 863.5 871.6 871.7 872.0 873.2 635.0 635.3 635.7 635.7 636.9 14058.8 14288.9 14305.4 14344.1 14408.5 14277.1 14415.6 14527.3 14591.5 14723.7 11363.5 11524.0 11569.0 11617.3 11784.4 3856.7 3872.1 3981.9 4042.4 4050.5 53734.7 54199.5 54272.7 54359.7 54741.0 10479.6 10548.6 10645.1 10693.8 10731.3 20510.5 20824.5 20855.6 20887.2 20888.0 8185.5 8212.8 8228.3 8266.3 8398.1 4642.4 4674.3 4706.6 4787.9 4825.9 3333.4 3433.0 3453.7 3456.2 3457.7 653.2 679.1 702.0 704.2 711.8 790.7 809.6 815.0 829.7 833.5 9708.7 9909.7 9996.2 10041.7 10238.7 731.0 763.6 781.3 796.8 799.9 4846.7 4926.5 4970.9 4972.5 4990.3 52096.7 53243.0 54077.0 65831.0 67930.3 54666.5 55625.7 55642.4 56344.4 57247.0 51389.5 51856.7 51881.0 51910.7 53159.7 9448.3 9519.1 9612.6 9649.6 9653.0 33151.0 34311.8 34613.7 35056.6 35104.6 45656.0 46076.3 46179.5 46542.8 47001.0 12367.9 12553.7 12723.9 12759.4 12835.9 13550.9 13734.7 14067.6 14405.7 14758.0 13003.0 13096.7 13210.9 13210.9 13389.5 10647.1 11331.5 11418.4 11564.0 12673.0 11839.4 11846.3 12262.3 12481.9 12672.9 9907.0 9907.4 9931.1 9938.5 9956.9 10402.1 10582.8 10628.1 10691.7 10692.2 07:27:44 INFO - PROCESS | 21244 | -------- Summary: end -------- 07:27:44 INFO - PROCESS | 21244 | 07:27:45 INFO - TEST-INFO | 21244: exit 0 07:27:45 INFO - TEST-OK | dromaeo_css | took 1110823ms 07:27:45 INFO - TEST-START | kraken 07:27:45 INFO - operating with platform_type : linux_ 07:27:45 INFO - Initialising browser for kraken test... 07:27:45 INFO - TEST-INFO | started process 21477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZoVpV/profile http://localhost:52148/getInfo.html) 07:27:49 INFO - PROCESS | 21477 | 07:27:49 INFO - PROCESS | 21477 | (process:21547): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:27:50 INFO - PROCESS | 21477 | __metrics Screen width/height:1600/1200 07:27:50 INFO - PROCESS | 21477 | colorDepth:24 07:27:50 INFO - PROCESS | 21477 | Browser inner width/height: 1024/697 07:27:50 INFO - PROCESS | 21477 | __metrics 07:27:50 ERROR - PROCESS | 21477 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 07:27:51 INFO - TEST-INFO | 21477: exit 0 07:27:51 INFO - Browser initialized. 07:27:51 INFO - Running cycle 1/1 for kraken test... 07:27:51 INFO - TEST-INFO | started process 21598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGZoVpV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:53 INFO - PROCESS | 21598 | 07:27:53 INFO - PROCESS | 21598 | (process:21660): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:03 INFO - PROCESS | 21598 | RSS: Main: 163020800 07:28:03 INFO - PROCESS | 21598 | 07:28:06 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:07 INFO - PROCESS | 21598 | RSS: Main: 167571456 07:28:07 INFO - PROCESS | 21598 | 07:28:09 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-dft) 07:28:10 INFO - PROCESS | 21598 | RSS: Main: 167661568 07:28:10 INFO - PROCESS | 21598 | 07:28:13 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-fft) 07:28:13 INFO - PROCESS | 21598 | RSS: Main: 162385920 07:28:13 INFO - PROCESS | 21598 | 07:28:16 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52148/tests/kraken/driver.html?testName=audio-oscillator) 07:28:16 INFO - PROCESS | 21598 | RSS: Main: 162983936 07:28:16 INFO - PROCESS | 21598 | 07:28:19 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:19 INFO - PROCESS | 21598 | RSS: Main: 163110912 07:28:19 INFO - PROCESS | 21598 | 07:28:22 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:23 INFO - PROCESS | 21598 | RSS: Main: 163520512 07:28:23 INFO - PROCESS | 21598 | 07:28:26 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52148/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:27 INFO - PROCESS | 21598 | RSS: Main: 162639872 07:28:27 INFO - PROCESS | 21598 | 07:28:30 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52148/tests/kraken/driver.html?testName=json-parse-financial) 07:28:31 INFO - PROCESS | 21598 | RSS: Main: 162750464 07:28:31 INFO - PROCESS | 21598 | 07:28:32 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:33 INFO - PROCESS | 21598 | RSS: Main: 163000320 07:28:33 INFO - PROCESS | 21598 | 07:28:35 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:35 INFO - PROCESS | 21598 | RSS: Main: 163065856 07:28:35 INFO - PROCESS | 21598 | 07:28:38 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:38 INFO - PROCESS | 21598 | RSS: Main: 163135488 07:28:38 INFO - PROCESS | 21598 | 07:28:41 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:42 INFO - PROCESS | 21598 | RSS: Main: 163627008 07:28:42 INFO - PROCESS | 21598 | 07:28:44 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:45 INFO - PROCESS | 21598 | RSS: Main: 163250176 07:28:45 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:52148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52148/tests/kraken/driver.html?testName=ai-astar) 07:28:47 INFO - PROCESS | 21598 | RSS: Main: 165130240 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | __start_tp_report 07:28:47 INFO - PROCESS | 21598 | _x_x_mozilla_page_load 07:28:47 INFO - PROCESS | 21598 | _x_x_mozilla_page_load_details 07:28:47 INFO - PROCESS | 21598 | |i|pagename|runs| 07:28:47 INFO - PROCESS | 21598 | |0;ai-astar;109;112;107;113;112;112;106;112;111;113 07:28:47 INFO - PROCESS | 21598 | |1;audio-beat-detection;152;127;151;212;127;155;160;134;180;127 07:28:47 INFO - PROCESS | 21598 | |2;audio-dft;162;162;163;164;167;171;166;163;165;164 07:28:47 INFO - PROCESS | 21598 | |3;audio-fft;76;77;76;168;76;75;75;76;177;75 07:28:47 INFO - PROCESS | 21598 | |4;audio-oscillator;92;93;180;97;92;93;153;93;93;151 07:28:47 INFO - PROCESS | 21598 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;118;117;119 07:28:47 INFO - PROCESS | 21598 | |6;imaging-darkroom;146;147;148;148;146;148;147;147;146;146 07:28:47 INFO - PROCESS | 21598 | |7;imaging-desaturate;96;95;95;96;95;95;96;95;96;96 07:28:47 INFO - PROCESS | 21598 | |8;json-parse-financial;59;59;65;59;59;60;69;58;59;61 07:28:47 INFO - PROCESS | 21598 | |9;json-stringify-tinderbox;60;60;59;60;62;59;59;60;59;60 07:28:47 INFO - PROCESS | 21598 | |10;stanford-crypto-aes;82;83;85;79;80;90;81;81;144;80 07:28:47 INFO - PROCESS | 21598 | |11;stanford-crypto-ccm;126;136;126;128;136;133;125;142;141;128 07:28:47 INFO - PROCESS | 21598 | |12;stanford-crypto-pbkdf2;168;167;168;168;173;168;170;170;173;171 07:28:47 INFO - PROCESS | 21598 | |13;stanford-crypto-sha256-iterative;69;64;67;65;68;63;68;66;65;72 07:28:47 INFO - PROCESS | 21598 | __end_tp_report 07:28:47 INFO - PROCESS | 21598 | __start_cc_report 07:28:47 INFO - PROCESS | 21598 | _x_x_mozilla_cycle_collect,850 07:28:47 INFO - PROCESS | 21598 | __end_cc_report 07:28:47 INFO - PROCESS | 21598 | __startTimestamp1462890527515__endTimestamp 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | ------- Summary: start ------- 07:28:47 INFO - PROCESS | 21598 | Number of tests: 14 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:2.57 07:28:47 INFO - PROCESS | 21598 | Values: 109.0 112.0 107.0 113.0 112.0 112.0 106.0 112.0 111.0 113.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:153.50 stddev:27.19 (17.7%) stddev-sans-first:28.84 07:28:47 INFO - PROCESS | 21598 | Values: 152.0 127.0 151.0 212.0 127.0 155.0 160.0 134.0 180.0 127.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.75 (1.7%) stddev-sans-first:2.74 07:28:47 INFO - PROCESS | 21598 | Values: 162.0 162.0 163.0 164.0 167.0 171.0 166.0 163.0 165.0 164.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.85 (53.8%) stddev-sans-first:42.74 07:28:47 INFO - PROCESS | 21598 | Values: 76.0 77.0 76.0 168.0 76.0 75.0 75.0 76.0 177.0 75.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#4] audio-oscillator Cycles:10 Average:113.70 Median:93.00 stddev:33.77 (36.3%) stddev-sans-first:34.90 07:28:47 INFO - PROCESS | 21598 | Values: 92.0 93.0 180.0 97.0 92.0 93.0 153.0 93.0 93.0 151.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:28:47 INFO - PROCESS | 21598 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:28:47 INFO - PROCESS | 21598 | Values: 146.0 147.0 148.0 148.0 146.0 148.0 147.0 147.0 146.0 146.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:28:47 INFO - PROCESS | 21598 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.50 stddev:3.49 (5.9%) stddev-sans-first:3.64 07:28:47 INFO - PROCESS | 21598 | Values: 59.0 59.0 65.0 59.0 59.0 60.0 69.0 58.0 59.0 61.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 07:28:47 INFO - PROCESS | 21598 | Values: 60.0 60.0 59.0 60.0 62.0 59.0 59.0 60.0 59.0 60.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:81.50 stddev:19.76 (24.2%) stddev-sans-first:20.82 07:28:47 INFO - PROCESS | 21598 | Values: 82.0 83.0 85.0 79.0 80.0 90.0 81.0 81.0 144.0 80.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:134.50 stddev:6.38 (4.7%) stddev-sans-first:6.38 07:28:47 INFO - PROCESS | 21598 | Values: 126.0 136.0 126.0 128.0 136.0 133.0 125.0 142.0 141.0 128.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:2.17 (1.3%) stddev-sans-first:2.22 07:28:47 INFO - PROCESS | 21598 | Values: 168.0 167.0 168.0 168.0 173.0 168.0 170.0 170.0 173.0 171.0 07:28:47 INFO - PROCESS | 21598 | 07:28:47 INFO - PROCESS | 21598 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.50 stddev:2.67 (4.0%) stddev-sans-first:2.70 07:28:47 INFO - PROCESS | 21598 | Values: 69.0 64.0 67.0 65.0 68.0 63.0 68.0 66.0 65.0 72.0 07:28:47 INFO - PROCESS | 21598 | -------- Summary: end -------- 07:28:47 INFO - PROCESS | 21598 | 07:28:48 INFO - TEST-INFO | 21598: exit 0 07:28:48 INFO - TEST-OK | kraken | took 63345ms 07:28:48 INFO - SUITE-END | took 1174s 07:28:48 INFO - Completed test suite (00:19:34) 07:28:48 INFO - javascript benchmark 07:28:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.369526094781, 3171.4767063434533, 3232.0303908827345, 3237.4820028795384, 3240.1089700332413, 5418.593605479595, 5447.645903016306, 5453.427390124039, 5529.060059789836, 5529.391766905637, 5346.679199248048, 5405.162199859028, 5442.455754424555, 5464.316960379952, 5553.250311207996, 4860.611151107921, 4907.2884431757375, 5026.874328141789, 5060.633628920189, 5124.564412024983, 910.5541503793978, 4848.17581011229, 4883.438404583465, 4958.0, 4965.155923493015, 4955.98402327522, 4962.206047032458, 4991.700497970097, 4997.100521906055, 5008.924866127011, 5014.52362025607, 5017.448080711119, 5024.924626130574, 5035.672681275705, 5086.41506226785, 4891.608671306322, 4906.582940450066, 4960.206366981266, 4972.701637901738, 4981.476944920803, 5369.919451208235, 5414.10667239905, 5434.212039254286, 5444.455554444564, 5469.617126801126, 5619.0, 5823.737931793079, 5828.5628577856405, 5847.473727364558, 5858.912116318259, 5933.436323549256, 5989.91015134769, 6008.24896887889, 6029.065494848305, 6064.272287325549, 5580.804671836507, 5585.720713964285, 5586.748596313135, 5602.551795856321, 5607.130894711327, 5853.970730146322, 5944.613600115978, 5992.191054207713, 6100.572959892765, 6115.205023346936, 5652.349979752381, 5660.037793575102, 5688.203651488795, 5688.345840228344, 5706.115552089433, 5780.94219057804, 5807.738651760681, 5834.591578589543, 5836.970815145897, 5838.357780644125, 5749.54003679713, 5768.423157684198, 5804.1293805929445, 5825.475707186373, 5827.970860145672, 5777.711114444261, 5808.332041815161, 5836.328822185418, 5855.355910849803, 5862.267216597926, 4326.134773045404, 4404.977975110104, 4442.733435993786, 4461.420015398043, 4483.887902802391, 3887.1642596841816, 3944.5069366329208, 3959.8614048508166, 3990.38149086892, 4006.0786019215743, 5510.0, 5519.31008623922, 5558.916616250759, 5612.550995920316, 5627.240322556484, 5832.679202643895, 5853.795117170964, 5874.823755287348, 5878.853028674317, 5881.647101173858, 5417.214503896913, 5527.39198688144, 5553.083741182741, 5570.610057296031, 5605.0751625982075, 5070.442251352349, 5081.872953176126, 5085.415177254663, 5095.592352611782, 5109.20807274873, 6059.21230240066, 6071.939280607137, 6091.725872335755, 6092.817215483543, 6112.510999120149, 5682.289713785777, 5748.568857335633, 5879.265091863432, 5881.676507792113, 5926.555508336978, 6090.908636370546, 6125.99826085224, 6128.8774224516155, 6129.756146212572, 6155.599886007395, 5833.445822646841, 5842.883142337215, 5847.210626565359, 5868.5305175585, 5873.442023007808, 5673.9432605675065, 5858.7110835616095, 5907.261592300963, 5909.23179986599, 5973.193618861398, 5744.798932037525, 5767.365589785037, 5796.971015144897, 5826.096954971986, 5826.242588463472, 5773.24947756789, 5792.0, 5803.332616749128, 5831.1544826000845, 5834.18321435008, 5505.889882202414, 5609.663420194638, 5612.943870561406, 5644.9435505644415, 5675.631083979528, 5783.219265399117, 5795.971020144872, 5827.621204621686, 5828.533717302521, 5844.298684157929, 5668.51817595509, 5672.177534257592, 5681.744321505625, 5683.8010669626365, 5686.09022556389], "value": 5377.779035982997, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4981915552627, 622.3745136138181, 642.9260635026973, 646.4569761400422, 646.8350570604496, 43064.78467607661, 44301.556984430186, 44652.3302150468, 44756.55243447565, 48500.0, 43590.0, 43962.34056489155, 44147.77926110373, 44166.558334416644, 44198.77900610492, 8939.642414303436, 8984.730458086267, 8986.0, 9014.639414423415, 9046.457212567235, 8758.343124265673, 8780.560971951378, 8839.0, 8839.73480795574, 8954.2836573074, 8935.776605584848, 8999.28005759541, 9019.2784577234, 9021.819563608724, 9031.367804253705, 8902.554872256362, 8935.32985026119, 8936.151065648754, 8943.77640558988, 9008.77478063047, 8700.956495217546, 8763.824723505559, 8768.605412756442, 8823.647054117828, 8833.425827321204, 42716.572834271574, 43059.784701076605, 43144.78427607873, 43172.784136079434, 43288.78355608233, 3419.606745224306, 3425.4519276915576, 3558.1282585766394, 3639.5632524097014, 3860.4209368594934, 32511.674883251337, 32565.83717081423, 32882.50676239858, 33223.16942076443, 33397.6660233397, 4353.825846966118, 4377.277749171383, 4380.693351465398, 4386.71486353386, 4426.358178064195, 236352.0, 311654.0, 313390.0, 313542.0, 313711.99999999773, 59524.55943007124, 60277.69861150754, 60548.0, 60732.0, 60791.39208607946, 36603.4509482358, 37758.244835103695, 37872.43191352132, 39835.00412489653, 39843.0, 16011.519654410386, 16080.195990200444, 16181.4336498222, 16194.43319483836, 16224.269907854175, 12581.559645412366, 12672.556460523838, 12709.300988445724, 12766.489340426464, 12777.16948398351, 19713.211471541264, 20180.192792288144, 20196.495087622632, 20334.0, 20374.79625203729, 7431.591262480615, 7529.510581812165, 7529.623518824037, 7556.0, 7671.424643151786, 964.4020707161604, 1035.6634093919356, 1086.326477583903, 1112.477135746198, 1170.3270619393882, 32355.0, 32629.67370326314, 32765.0, 32810.67189328076, 33151.171220719196, 1163.3310846263264, 1184.4729095552568, 1186.400867561893, 1226.4910062324213, 1269.1306455078302, 16873.746893796604, 17317.4804755855, 17337.739933901, 17497.825021749875, 17599.824001760073, 457595.0, 459822.0, 460370.0, 461037.0, 461368.0, 58991.0, 59393.0, 59858.401415986154, 60347.69826150841, 60427.69786151041, 1382.67507135823, 1386.909850859711, 1410.9576712698636, 1416.355558221007, 1423.800667906494, 30971.070867874, 30973.69026309708, 31539.36921261516, 32099.839500802347, 32272.83863580667, 50988.0, 51033.0, 51368.48631513637, 51412.0, 51488.48511514837, 375634.0, 379627.0, 379840.0, 380794.0, 382176.0, 28342.149735507966, 28425.147245582666, 28498.0, 28555.857220713762, 28596.571051433828, 46886.29670554876, 48391.0, 49446.50553494419, 51231.0, 51743.22385164301, 42123.0, 42799.35800962926, 42952.57047429486, 42980.57019429766, 44074.77962610166, 40432.79783601181, 40979.795101024305, 41851.372229415974, 41971.16057678768, 43152.35271470868, 42821.0, 43032.0, 43741.78129109334, 44048.11903761971, 45940.77029614831, 36721.63278367289, 37332.81333593315, 37580.0, 37678.62321376861, 38006.42990355092, 28319.716802831706, 28736.137915862557, 28757.42485150327, 29205.269868253465, 29230.853845731486], "value": 20013.397830569418, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.2750504102696, 407.3482428115016, 408.72615347717027, 410.09369293860567, 422.9767362795047, 17560.385386511476, 18705.25178992842, 19113.426597202073, 19209.423717288468, 19499.805001949975, 18828.152733127008, 18854.057297135158, 19084.0, 19718.0, 19747.70378444321, 5493.423190564993, 5510.201020851974, 5758.337791154029, 5759.740811663485, 5771.3074431068335, 5646.096624540074, 5681.0, 5686.943130568683, 5687.630304030225, 5712.0860662293835, 5470.671759694411, 5596.804111856066, 5627.043402621564, 5654.123610840326, 5683.2895888014, 5422.864428389283, 5638.774449022055, 5652.265205523277, 5662.122371032456, 5673.205751194836, 5009.949900500985, 5014.348134742497, 5077.593792496628, 5108.897822043538, 5118.744062796883, 16705.081220532866, 19220.519487012796, 22106.557868842534, 22315.888420557956, 22369.0, 2360.268316821791, 2392.2583998960376, 2428.3200703802963, 2568.9229323120335, 2742.657167854018, 14445.133292002514, 14805.629859253497, 14876.0, 14929.253537323091, 15059.247037648183, 1944.6013567218827, 2026.9189232430685, 2043.5402034542258, 2055.4758536573227, 2106.73665791776, 77204.22795772027, 80716.19283807205, 81241.0, 81901.18098818995, 82032.0, 10272.33229840058, 10380.532876020598, 10781.676549703521, 10803.675889723321, 10871.619493317696, 15234.619134521725, 15325.0, 15333.539993800205, 15336.539903802905, 15361.846381536265, 7737.922620773833, 7808.414368922354, 7850.371970242367, 7871.685132594632, 8011.679532818622, 7163.641817909083, 7179.174394944648, 7179.856402871913, 7538.698452061966, 7540.208278130827, 6516.869662606721, 6614.669266536654, 6672.666366681647, 6677.662818013657, 6705.228898676714, 1925.6341295153875, 1963.4306051244978, 1966.7639883214106, 1982.8413726901813, 2018.7880272571463, 978.5449765858909, 1059.5580553643883, 1064.9787004259872, 1093.868735751715, 1095.884932082136, 17538.386156484463, 19026.61946761057, 19319.13063912099, 19338.226470941285, 19630.502243984116, 1084.446932064637, 1085.9239853210358, 1105.5854054729477, 1170.9941450292695, 1192.934388608635, 10951.671449856518, 11035.724106897393, 11164.832527512093, 11243.60647377338, 11246.831297530543, 460304.0, 466657.0, 467825.0, 498776.0, 504145.0, 55155.44844551503, 71702.0, 73076.63461682764, 77354.6132269335, 80076.19923800687, 1087.896649818266, 1098.7088421568292, 1119.4906317625462, 1119.6417146513038, 1135.949246946571, 17391.0, 17583.0, 17721.55696107556, 17769.73345399846, 17974.91012544929, 36888.61405888403, 37228.813855930544, 38463.423048653734, 38522.6147738519, 39381.2123757529, 49365.25952110793, 50086.0, 50357.0, 50627.746861265456, 50677.74661126671, 8765.0, 8770.12298770118, 8855.867161992446, 9012.233960113464, 9049.457032578066, 12197.573084941985, 13359.933200333937, 13396.93301533486, 14004.089734167246, 14241.430342786587, 11743.706407339885, 11844.348560829238, 11985.940070299594, 12080.308756773882, 12129.272243665408, 11753.941230293794, 12023.699407514881, 12065.276083435023, 12170.330631815335, 12223.449944752685, 12099.153059285765, 12161.087918405978, 12193.57322493744, 12211.816822747489, 12356.3821808911, 8946.0, 9172.312076594415, 9173.312001599774, 9265.212456941235, 9381.296402769956, 11637.127215458706, 11969.820452693042, 12019.338936358585, 12122.636320910387, 12191.939040304742], "value": 9347.933980276135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.6540030392703, 1509.2076659753627, 1622.2537632688961, 1853.620007898381, 1854.3046357615901, 7882.172371900954, 8257.380696447768, 8313.376496762738, 8869.68956086537, 8899.95550022249, 8525.062243153248, 8694.0, 8740.737777866658, 8779.824403511926, 8792.560371981392, 2333.4516388648694, 2362.822788290885, 2363.3382652857226, 2367.95264094718, 2367.981767839828, 2296.977030229693, 2326.8487548309304, 2369.668246445499, 2378.322178179211, 2379.7858192762646, 2290.7365652949875, 2307.0541078157958, 2314.4445333120016, 2314.872682002489, 2333.4866329407505, 2292.3466811958597, 2317.9884100579557, 2322.1524143687516, 2323.3146221864504, 2343.367290831466, 2269.5687819314444, 2297.5979203639463, 2304.7349554801076, 2308.0652335804025, 2314.0281081945623, 8767.956160219223, 8834.425762325429, 8903.0, 8906.643734250621, 8921.286297096216, 5176.0683077046115, 5296.285001524783, 5304.177852432879, 5344.732763361816, 5362.973185134088, 3278.49183376577, 3292.0946739646547, 3437.364087643769, 3490.703290220334, 3510.350585141757, 1121.2151493954264, 1128.3230061962756, 1140.4639819284923, 1147.0192984997873, 1178.298912147271, 11810.350430726221, 11833.526658933632, 11949.342786146759, 11955.342456164908, 11984.880151198464, 4581.518940511265, 4587.564181402761, 4758.262469317261, 4802.783874725646, 4819.903601928012, 9804.558794854249, 9883.950580247052, 9932.106110450095, 9939.353941993748, 9950.751231219132, 5296.576273898079, 5310.707911064851, 5312.389075256395, 5316.601254905898, 5328.493793089728, 4243.151369726067, 4870.439899411542, 4916.434610019894, 4957.405111386656, 5017.272495488134, 3742.288965096677, 3770.3967365221433, 3836.2327534492656, 3845.750026248341, 3849.0569810396632, 1162.3026184289358, 1167.229628445222, 1167.96496105117, 1175.1538891997748, 1185.4191446191476, 987.6740675577042, 1022.8772547294373, 1041.510490069666, 1048.046277887119, 1082.5886163257912, 6019.337872833985, 6286.5599408041, 6329.778457753957, 6332.176817013851, 6443.097966284724, 425.2642927735036, 433.87417648882104, 437.8970941828668, 446.30599417905466, 459.7195710616521, 4255.1915136124035, 4345.500267469281, 4371.0820727646915, 4431.40176076232, 4466.575675310905, 10737.946310268555, 11065.778684426266, 11077.556897724162, 11120.165987550967, 11160.0513956313, 10702.357858528514, 10737.624183153552, 10954.835677464844, 10960.890391096147, 11071.391073491035, 8222.17778222185, 8262.215089566362, 8318.958405207935, 8328.417010809186, 8431.114732953074, 5895.4399332063385, 5985.371535988833, 6025.1564780931585, 6308.621482711052, 6353.396427339396, 9937.602495900082, 10009.749756256151, 10052.849207262043, 10104.04011618895, 10158.847617285599, 10218.233632477446, 10323.94838025835, 10413.84379234297, 10554.525046373084, 10631.617889674293, 7219.819504512429, 7626.504277221963, 7783.805404864924, 7847.450678452454, 7993.6003199838615, 8727.869081963649, 8737.169968852948, 8743.256823170103, 8807.427517211361, 8898.510581918057, 7686.231376862493, 7819.374450044096, 7928.7621371358955, 7934.404919630935, 7944.880826787487, 7657.4256930731535, 7745.341645960157, 7817.882731758915, 7829.686812527435, 7942.483738556975, 7334.486585938933, 7336.339729424378, 7364.852702946018, 7403.185649578434, 7406.407487401103, 5573.860653483695, 5601.355844077821, 5610.579206559606, 5659.151127330769, 5689.800856969986, 5372.301600791872, 5409.0, 5469.699166545719, 5517.089680202722, 5556.555475562026], "value": 4600.707268131287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.5554029829878, 348.46684572603914, 348.93021395720854, 351.6501081423983, 355.486322264328, 5468.343798744151, 5645.830625081254, 5647.701028763387, 5674.574406919477, 5678.829635110953, 5541.0, 5550.306211723535, 5551.555875529958, 5563.972180139103, 5577.772889964202, 4091.0, 4374.803133858984, 4392.450943632046, 4409.250427427345, 4421.425214722081, 3965.246603145408, 4313.525512193656, 4317.740935543861, 4330.740155590659, 4347.391365208873, 4328.4156638853665, 4344.826206951734, 4357.324614684729, 4364.563543645641, 4378.693491455583, 4307.719998200123, 4323.329883868006, 4342.5874541918465, 4374.34384842273, 4374.4531933508315, 3577.123604716835, 3767.9434808477895, 3772.000419888732, 3791.50710407648, 3878.3600705883496, 5399.406065332811, 5423.457654234545, 5434.755436005389, 5443.755031023574, 5453.890922181574, 4932.408111026664, 4975.3532040834825, 4981.526754958273, 4999.250112483121, 5039.420466646346, 5609.523190528769, 5889.646621202742, 5890.582063452411, 5913.586048976574, 5922.3485416604135, 4183.1215444756635, 4189.601987811153, 4195.580441955811, 4220.556841531657, 4241.2365774160635, 5794.913076303858, 5841.912371314434, 6171.382861713838, 6198.566100372976, 6224.719887605069, 4170.562090980464, 4232.555581663943, 4248.787560621957, 4249.830006799693, 4282.250606143913, 4284.365115453973, 4326.610605045561, 4344.630706389929, 4350.260455722535, 4355.932796464823, 4828.444728856156, 4901.044296362175, 4977.502249774993, 4992.875178120504, 5004.799808007639, 5879.0, 5894.0, 5896.115582662635, 5918.129707092057, 5918.201042859159, 1467.7358075546504, 1477.7044591081826, 1481.3482067890309, 1499.212913220568, 1506.3823832228734, 925.4308600210821, 945.385499425379, 956.4266781144978, 959.5873774276988, 970.4904924914476, 5021.372328458942, 5021.723805190676, 5028.974855125701, 5031.566003689004, 5035.949640503622, 5222.328854766438, 5255.710935898563, 5349.522810173418, 5367.812126575551, 5372.435894231127, 5061.544460998528, 5068.315777370081, 5100.234964755242, 5282.524572788468, 5787.276590426197, 3232.6767323267486, 3272.9672703272663, 3273.0344548358294, 3284.4088064148204, 3288.9475367882046, 6058.303295121029, 6252.406021427957, 6262.4990000800735, 6277.52918531112, 6352.872942541123, 6210.782622608187, 6214.751409943552, 6218.129461875341, 6231.189945307081, 6233.594816337014, 6280.591761535486, 6309.968450157719, 6314.810555683337, 6324.08300796382, 6338.397852204033, 5795.913061304, 6038.456538911519, 6054.215061071956, 6091.177691011834, 6096.390360964046, 6028.819135425944, 6029.336772955059, 6044.546659000681, 6052.243469566304, 6064.545159112996, 5978.880422391615, 6070.271567411939, 6239.594426362272, 6242.843928901632, 6312.905306420499, 4270.188664153801, 4279.716085174373, 4280.871573852789, 4295.968967447852, 4298.806553705028, 5848.970755146197, 5997.16039754426, 6024.487918526975, 6025.849353766191, 6073.210482637405, 5765.019946609003, 5806.68063256525, 5836.649801011953, 5848.444397782204, 5879.0, 5849.766009359748, 5866.530677545871, 5904.675242861684, 5912.379200184091, 5916.201312822886, 5639.943600563942, 5686.289213848269, 5822.94177058241, 5864.237649105759, 5864.44287792659, 5887.293524777054, 5949.382271800394, 5970.507373156711, 6026.186464827192, 6044.304904935812, 5464.590155738256, 5767.452092051416, 5813.476787089182, 5839.941600583939, 5873.678422354936], "value": 4433.751182303015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.75754122369, 745.0463406839248, 747.7868807389895, 748.5284270909328, 763.713607397226, 13710.794338084925, 14348.569542913703, 14452.06061605995, 14583.270836458174, 14589.343479543419, 14093.647658808535, 14147.504837330696, 14148.646283842909, 14169.0, 14190.21953792541, 678.7861823525586, 797.0037453183521, 817.0767033252416, 820.7004443378183, 822.284612387224, 809.5587904591982, 811.9837603247931, 819.5001049359886, 820.2248874813304, 823.0822632764455, 865.1996902864856, 866.5667166416791, 868.68727258187, 869.74342568942, 873.9825203495926, 863.4732812984074, 871.5511511571545, 871.7254064969546, 871.960761765722, 873.1792115411524, 635.034747184282, 635.3043417457876, 635.71710588788, 635.7393468677866, 636.936306369364, 14058.789118163235, 14288.857111428857, 14305.427782888672, 14344.13935163883, 14408.495702650462, 14277.143371397646, 14415.567532974028, 14527.346269417796, 14591.54084591543, 14723.705525889422, 11363.545458181663, 11524.0, 11569.016633586156, 11617.302961822234, 11784.410779460992, 3856.730028897978, 3872.1094148345755, 3981.900452488682, 4042.43405923171, 4050.51393832739, 53734.731326343506, 54199.45800541984, 54272.72863635696, 54359.72820135874, 54741.0, 10479.633212837514, 10548.630797922036, 10645.095166910745, 10693.786124277627, 10731.302465339728, 20510.487237818874, 20824.47938801542, 20855.58288834215, 20887.164513419597, 20888.0, 8185.467944583583, 8212.8357432851, 8228.25945664893, 8266.297364723945, 8398.118197589287, 4642.37327960721, 4674.298855171752, 4706.623470122382, 4787.8563643090765, 4825.9034819303415, 3333.3666603345287, 3433.0, 3453.723702103826, 3456.1532424556144, 3457.740669449751, 653.1574269192784, 679.0730652659084, 701.9894701579481, 704.2183176673888, 711.8425618400873, 790.675822912603, 809.554744890308, 814.9511029338258, 829.6971605363999, 833.5332213960202, 9708.708738737849, 9909.65316213929, 9996.150327222267, 10041.748956276151, 10238.692839214835, 731.042334541752, 763.6181909045478, 781.2695130053419, 796.8047828282108, 799.8960135182506, 4846.733429661403, 4926.531979462017, 4970.850874473772, 4972.477889821516, 4990.2764099205415, 52096.73951630218, 53243.0, 54077.0, 65831.0, 67930.3206967924, 54666.45333546693, 55625.721871390386, 55642.44357556454, 56344.43655563474, 57247.0, 51389.486105139214, 51856.740716296175, 51881.0, 51910.74044629828, 53159.73420132952, 9448.338616297067, 9519.095685909828, 9612.615495380107, 9649.565769540248, 9652.951735241279, 33151.0, 34311.82844085764, 34613.65386346104, 35056.59773609027, 35104.648953510135, 45656.0, 46076.30885536653, 46179.53820461752, 46542.767286163355, 47001.0, 12367.876321236672, 12553.701891796629, 12723.872761272269, 12759.362031898554, 12835.871641283467, 13550.93224533871, 13734.725305494034, 14067.577972660836, 14405.711885762435, 14758.0, 13003.0, 13096.672583185496, 13210.867891320964, 13210.933945330213, 13389.464421423034, 10647.094996925349, 11331.546738130382, 11418.371989540656, 11564.0, 12673.0, 11839.408029598659, 11846.289222646668, 12262.26426414418, 12481.875181248435, 12672.936635316764, 9907.0, 9907.356021858555, 9931.106200441705, 9938.503074846085, 9956.900430995598, 10402.115820155372, 10582.788344233226, 10628.149748020294, 10691.679249622213, 10692.19808514349], "value": 6877.168129460872, "unit": "score"}], "name": "dromaeo_css", "value": 7215.748318829588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 107.0, 113.0, 112.0, 112.0, 106.0, 112.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 151.0, 212.0, 127.0, 155.0, 160.0, 134.0, 180.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 167.0, 171.0, 166.0, 163.0, 165.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 168.0, 76.0, 75.0, 75.0, 76.0, 177.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 180.0, 97.0, 92.0, 93.0, 153.0, 93.0, 93.0, 151.0], "value": 113.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 65.0, 59.0, 59.0, 60.0, 69.0, 58.0, 59.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 62.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 85.0, 79.0, 80.0, 90.0, 81.0, 81.0, 144.0, 80.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 126.0, 128.0, 136.0, 133.0, 125.0, 142.0, 141.0, 128.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 168.0, 168.0, 173.0, 168.0, 170.0, 170.0, 173.0, 171.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 67.0, 65.0, 68.0, 63.0, 68.0, 66.0, 65.0, 72.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1574.1999999999998, "alertThreshold": 2.0}]} 07:28:48 INFO - Return code: 0 07:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:48 ERROR - # TBPL SUCCESS # 07:28:48 INFO - Running post-action listener: _resource_record_post_action 07:28:48 INFO - ##### 07:28:48 INFO - ##### Finished run-tests step (success) 07:28:48 INFO - ##### 07:28:48 INFO - Running post-run listener: _resource_record_post_run 07:28:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534876160; Read time: 16; Write time: 750316 07:28:49 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244822016; Read time: 0; Write time: 440344 07:28:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290054144; Read time: 16; Write time: 309972 07:28:49 INFO - Running post-run listener: _upload_blobber_files 07:28:49 INFO - Blob upload gear active. 07:28:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:49 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:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:28:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:28:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:51 INFO - (blobuploader) - INFO - Done attempting. 07:28:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:28:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:51 INFO - (blobuploader) - INFO - Done attempting. 07:28:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:51 INFO - Return code: 0 07:28:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d7ca3819439a6c9e0dcbfaac02a038c223ffb0c11b6f263e4bcb9e6c9e7c06073702cc2ed7aa3d5bc222150f9f96a5f5b5dc32dfc6f23ca666aa7259af659d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d6a19ee9c6aca225dca00bcbd33d99f5321cd167c0a6ec037b87da1404d66cb1f9f8777c83f89041936bec3e74eb83584ef11a788552fb6956f4c48d1fc4c95"} 07:28:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:51 INFO - Contents: 07:28:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d7ca3819439a6c9e0dcbfaac02a038c223ffb0c11b6f263e4bcb9e6c9e7c06073702cc2ed7aa3d5bc222150f9f96a5f5b5dc32dfc6f23ca666aa7259af659d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d6a19ee9c6aca225dca00bcbd33d99f5321cd167c0a6ec037b87da1404d66cb1f9f8777c83f89041936bec3e74eb83584ef11a788552fb6956f4c48d1fc4c95"} 07:28:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:51 INFO - Copying logs to upload dir... 07:28:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.948184 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-10 07:28:51.611118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 07:28:51.614890) ========= 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=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d7ca3819439a6c9e0dcbfaac02a038c223ffb0c11b6f263e4bcb9e6c9e7c06073702cc2ed7aa3d5bc222150f9f96a5f5b5dc32dfc6f23ca666aa7259af659d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d6a19ee9c6aca225dca00bcbd33d99f5321cd167c0a6ec037b87da1404d66cb1f9f8777c83f89041936bec3e74eb83584ef11a788552fb6956f4c48d1fc4c95"} build_url:https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/OAUAHJPDQxySiWOy9ZBjKw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3d7ca3819439a6c9e0dcbfaac02a038c223ffb0c11b6f263e4bcb9e6c9e7c06073702cc2ed7aa3d5bc222150f9f96a5f5b5dc32dfc6f23ca666aa7259af659d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d6a19ee9c6aca225dca00bcbd33d99f5321cd167c0a6ec037b87da1404d66cb1f9f8777c83f89041936bec3e74eb83584ef11a788552fb6956f4c48d1fc4c95"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 07:28:51.639268) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:28:51.639599) ========= 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=52faae308a556c440401f8e5000001e8-1462885214.974292-159627447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 07:28:51.723375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 07:28:51.723719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 07:28:51.724019) ========= ========= Total master_lag: 0.15 =========