builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1467042899.66 results: success (0) buildid: 20160627060726 builduid: ef878fa29e9c42188a5376b679b121c6 revision: b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.663753) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.664231) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.664551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.681528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.681821) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:54:59-- 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% 46.4M=0s 2016-06-27 08:54:59 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.851429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.851871) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015681 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:54:59.905553) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:54:59.906304) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 --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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:55:00,083 truncating revision to first 12 chars 2016-06-27 08:55:00,083 Setting DEBUG logging. 2016-06-27 08:55:00,083 attempt 1/10 2016-06-27 08:55:00,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b7f4630c2e64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:55:01,361 unpacking tar archive at: mozilla-beta-b7f4630c2e64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.659900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:55:01.585845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:55:01.586873) ========= script_repo_revision: b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:55:01.588024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:55:01.588907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:55:01.602244) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 08:55:01.602620) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:55:01 INFO - MultiFileLogger online at 20160627 08:55:01 in /builds/slave/test 08:55:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:55:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:01 INFO - {'append_to_log': False, 08:55:01 INFO - 'base_work_dir': '/builds/slave/test', 08:55:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:55:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:01 INFO - 'branch': 'Mozilla-Beta', 08:55:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:01 INFO - 'config_files': ('talos/linux_config.py',), 08:55:01 INFO - 'default_actions': ('clobber', 08:55:01 INFO - 'read-buildbot-config', 08:55:01 INFO - 'download-and-extract', 08:55:01 INFO - 'populate-webroot', 08:55:01 INFO - 'create-virtualenv', 08:55:01 INFO - 'install', 08:55:01 INFO - 'run-tests'), 08:55:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:01 INFO - 'download_minidump_stackwalk': True, 08:55:01 INFO - 'download_symbols': 'ondemand', 08:55:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:01 INFO - 'installer_path': 'installer.exe', 08:55:01 INFO - 'log_level': 'info', 08:55:01 INFO - 'log_name': 'talos', 08:55:01 INFO - 'log_to_console': True, 08:55:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:55:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:55:01 INFO - 'opt_config_files': (), 08:55:01 INFO - 'pip_index': False, 08:55:01 INFO - 'sps_profile': False, 08:55:01 INFO - 'sps_profile_interval': 0, 08:55:01 INFO - 'suite': 'dromaeojs-e10s', 08:55:01 INFO - 'system_bits': '32', 08:55:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:01 INFO - 'title': 'talos-linux64-ix-015', 08:55:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:01 INFO - 'use_talos_json': True, 08:55:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:01 INFO - 'work_dir': 'build'} 08:55:01 INFO - ##### 08:55:01 INFO - ##### Running clobber step. 08:55:01 INFO - ##### 08:55:01 INFO - Running pre-action listener: _resource_record_pre_action 08:55:01 INFO - Running main action method: clobber 08:55:01 INFO - rmtree: /builds/slave/test/build 08:55:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:02 INFO - Running post-action listener: _resource_record_post_action 08:55:02 INFO - ##### 08:55:02 INFO - ##### Running read-buildbot-config step. 08:55:02 INFO - ##### 08:55:02 INFO - Running pre-action listener: _resource_record_pre_action 08:55:02 INFO - Running main action method: read_buildbot_config 08:55:02 INFO - Using buildbot properties: 08:55:02 INFO - { 08:55:02 INFO - "project": "", 08:55:02 INFO - "product": "firefox", 08:55:02 INFO - "script_repo_revision": "production", 08:55:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:55:02 INFO - "repository": "", 08:55:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:55:02 INFO - "buildid": "20160627060726", 08:55:02 INFO - "pgo_build": "True", 08:55:02 INFO - "basedir": "/builds/slave/test", 08:55:02 INFO - "buildnumber": 152, 08:55:02 INFO - "slavename": "talos-linux64-ix-015", 08:55:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:55:02 INFO - "platform": "ubuntu64_hw", 08:55:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:55:02 INFO - "branch": "mozilla-beta", 08:55:02 INFO - "repo_path": "releases/mozilla-beta", 08:55:02 INFO - "revision": "b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2", 08:55:02 INFO - "stage_platform": "linux64-pgo", 08:55:02 INFO - "builduid": "ef878fa29e9c42188a5376b679b121c6", 08:55:02 INFO - "slavebuilddir": "test" 08:55:02 INFO - } 08:55:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:55:02 INFO - Running post-action listener: _resource_record_post_action 08:55:02 INFO - ##### 08:55:02 INFO - ##### Running download-and-extract step. 08:55:02 INFO - ##### 08:55:02 INFO - Running pre-action listener: _resource_record_pre_action 08:55:02 INFO - Running main action method: download_and_extract 08:55:02 INFO - mkdir: /builds/slave/test/build/tests 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:02 INFO - https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:55:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:55:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:55:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:55:07 INFO - Downloaded 1327 bytes. 08:55:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:55:07 INFO - Using the following test package requirements: 08:55:07 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:55:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:55:07 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:55:07 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'jsshell-linux-x86_64.zip'], 08:55:07 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:55:07 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:55:07 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:55:07 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:55:07 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:55:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:55:07 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:55:07 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:55:07 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')]} 08:55:07 INFO - https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:55:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:55:12 INFO - Downloaded 24235707 bytes. 08:55:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:55:13 INFO - Return code: 0 08:55:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:55: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')]} 08:55:13 INFO - https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:55:16 INFO - Downloaded 24235707 bytes. 08:55:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:55:17 INFO - Return code: 0 08:55: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')]} 08:55:17 INFO - https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:55:18 INFO - Downloaded 10840145 bytes. 08:55:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:55:19 INFO - Return code: 0 08:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:19 INFO - https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:55:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:55:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:55:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:55:20 INFO - Downloaded 56008575 bytes. 08:55:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:55:20 INFO - mkdir: /builds/slave/test/properties 08:55:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:20 INFO - Contents: 08:55:20 INFO - build_url:https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:55:21 INFO - Running post-action listener: _resource_record_post_action 08:55:21 INFO - Running post-action listener: set_extra_try_arguments 08:55:21 INFO - ##### 08:55:21 INFO - ##### Running populate-webroot step. 08:55:21 INFO - ##### 08:55:21 INFO - Running pre-action listener: _resource_record_pre_action 08:55:21 INFO - Running main action method: populate_webroot 08:55:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:21 INFO - '--tppagecycles', 08:55:21 INFO - '7'], 08:55:21 INFO - 'tests': ['tsvgm']}}, 08:55:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['damp', 'tps']}, 08:55:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'tests': ['damp', 'tps']}, 08:55:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['dromaeo_dom']}, 08:55:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['a11yr', 08:55:21 INFO - 'ts_paint', 08:55:21 INFO - 'tpaint', 08:55:21 INFO - 'sessionrestore', 08:55:21 INFO - 'sessionrestore_no_auto_restore', 08:55:21 INFO - 'tabpaint']}, 08:55:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['tsvgx', 08:55:21 INFO - 'tsvgr_opacity', 08:55:21 INFO - 'tart', 08:55:21 INFO - 'tscrollx', 08:55:21 INFO - 'cart']}, 08:55:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:21 INFO - 'tsvgr_opacity', 08:55:21 INFO - 'tart', 08:55:21 INFO - 'tscrollx', 08:55:21 INFO - 'cart']}, 08:55:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'talos_options': ['--disable-e10s'], 08:55:21 INFO - 'tests': ['tp5o']}, 08:55:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'tests': ['tp5o']}, 08:55:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'talos_options': ['--disable-e10s', 08:55:21 INFO - '--xperf_path', 08:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:21 INFO - 'tests': ['tp5n']}, 08:55:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:21 INFO - 'talos_options': ['--xperf_path', 08:55:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:21 INFO - 'tests': ['tp5n']}}, 08:55:21 INFO - 'talos.zip': {'path': '', 08:55:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:21 INFO - Running post-action listener: _resource_record_post_action 08:55:21 INFO - ##### 08:55:21 INFO - ##### Running create-virtualenv step. 08:55:21 INFO - ##### 08:55:21 INFO - Running pre-action listener: _resource_record_pre_action 08:55:21 INFO - Running main action method: create_virtualenv 08:55:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:55:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:21 INFO - Using real prefix '/usr' 08:55:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:21 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:23 INFO - Installing pip.................done. 08:55:23 INFO - Return code: 0 08:55:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:23 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')]} 08:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 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')]} 08:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:23 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 08:55:23 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 08:55:23 INFO - Using env: {'DISPLAY': ':0', 08:55:23 INFO - 'HOME': '/home/cltbld', 08:55:23 INFO - 'LANG': 'en_US.UTF-8', 08:55:23 INFO - 'LANGUAGE': 'en_US:en', 08:55:23 INFO - 'LOGNAME': 'cltbld', 08:55:23 INFO - 'MAIL': '/var/mail/cltbld', 08:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:23 INFO - 'MOZ_NO_REMOTE': '1', 08:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:23 INFO - 'NO_EM_RESTART': '1', 08:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:23 INFO - 'PWD': '/builds/slave/test', 08:55:23 INFO - 'SHELL': '/bin/bash', 08:55:23 INFO - 'SHLVL': '1', 08:55:23 INFO - 'TERM': 'linux', 08:55:23 INFO - 'TMOUT': '86400', 08:55:23 INFO - 'USER': 'cltbld', 08:55:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:23 INFO - '_': '/tools/buildbot/bin/python'} 08:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:23 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 08:55:23 INFO - Cleaning up... 08:55:23 INFO - Return code: 0 08:55:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:55:23 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')]} 08:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 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')]} 08:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:23 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:23 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 08:55:23 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 08:55:23 INFO - Using env: {'DISPLAY': ':0', 08:55:23 INFO - 'HOME': '/home/cltbld', 08:55:23 INFO - 'LANG': 'en_US.UTF-8', 08:55:23 INFO - 'LANGUAGE': 'en_US:en', 08:55:23 INFO - 'LOGNAME': 'cltbld', 08:55:23 INFO - 'MAIL': '/var/mail/cltbld', 08:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:23 INFO - 'MOZ_NO_REMOTE': '1', 08:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:23 INFO - 'NO_EM_RESTART': '1', 08:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:23 INFO - 'PWD': '/builds/slave/test', 08:55:23 INFO - 'SHELL': '/bin/bash', 08:55:23 INFO - 'SHLVL': '1', 08:55:23 INFO - 'TERM': 'linux', 08:55:23 INFO - 'TMOUT': '86400', 08:55:23 INFO - 'USER': 'cltbld', 08:55:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:23 INFO - '_': '/tools/buildbot/bin/python'} 08:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:24 INFO - Downloading/unpacking psutil>=0.7.1 08:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:26 INFO - Installing collected packages: psutil 08:55:26 INFO - Running setup.py install for psutil 08:55:26 INFO - building 'psutil._psutil_linux' extension 08:55:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:55:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:55:26 INFO - building 'psutil._psutil_posix' extension 08:55:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:55:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:26 INFO - Successfully installed psutil 08:55:26 INFO - Cleaning up... 08:55:26 INFO - Return code: 0 08:55:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:26 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:26 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 08:55:26 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 08:55:26 INFO - Using env: {'DISPLAY': ':0', 08:55:26 INFO - 'HOME': '/home/cltbld', 08:55:26 INFO - 'LANG': 'en_US.UTF-8', 08:55:26 INFO - 'LANGUAGE': 'en_US:en', 08:55:26 INFO - 'LOGNAME': 'cltbld', 08:55:26 INFO - 'MAIL': '/var/mail/cltbld', 08:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:26 INFO - 'MOZ_NO_REMOTE': '1', 08:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:26 INFO - 'NO_EM_RESTART': '1', 08:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:26 INFO - 'PWD': '/builds/slave/test', 08:55:26 INFO - 'SHELL': '/bin/bash', 08:55:26 INFO - 'SHLVL': '1', 08:55:26 INFO - 'TERM': 'linux', 08:55:26 INFO - 'TMOUT': '86400', 08:55:26 INFO - 'USER': 'cltbld', 08:55:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:26 INFO - '_': '/tools/buildbot/bin/python'} 08:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:55:26 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 08:55:26 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 08:55:26 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 08:55:26 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 08:55:26 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 08:55:26 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 08:55:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:55:28 INFO - Installing collected packages: mozsystemmonitor 08:55:28 INFO - Running setup.py install for mozsystemmonitor 08:55:28 INFO - Successfully installed mozsystemmonitor 08:55:28 INFO - Cleaning up... 08:55:29 INFO - Return code: 0 08:55:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:55:29 INFO - Using env: {'DISPLAY': ':0', 08:55:29 INFO - 'HOME': '/home/cltbld', 08:55:29 INFO - 'LANG': 'en_US.UTF-8', 08:55:29 INFO - 'LANGUAGE': 'en_US:en', 08:55:29 INFO - 'LOGNAME': 'cltbld', 08:55:29 INFO - 'MAIL': '/var/mail/cltbld', 08:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:29 INFO - 'MOZ_NO_REMOTE': '1', 08:55:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:29 INFO - 'NO_EM_RESTART': '1', 08:55:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:29 INFO - 'PWD': '/builds/slave/test', 08:55:29 INFO - 'SHELL': '/bin/bash', 08:55:29 INFO - 'SHLVL': '1', 08:55:29 INFO - 'TERM': 'linux', 08:55:29 INFO - 'TMOUT': '86400', 08:55:29 INFO - 'USER': 'cltbld', 08:55:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:29 INFO - '_': '/tools/buildbot/bin/python'} 08:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:55:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:55:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:31 INFO - Downloading docopt-0.6.1.tar.gz 08:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:55:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:55:31 INFO - Running setup.py install for blobuploader 08:55:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:55:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:55:31 INFO - Running setup.py install for requests 08:55:32 INFO - Running setup.py install for docopt 08:55:32 INFO - Successfully installed blobuploader requests docopt 08:55:32 INFO - Cleaning up... 08:55:32 INFO - Return code: 0 08:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:32 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')]} 08:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:32 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')]} 08:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:32 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:32 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 08:55:32 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 08:55:32 INFO - Using env: {'DISPLAY': ':0', 08:55:32 INFO - 'HOME': '/home/cltbld', 08:55:32 INFO - 'LANG': 'en_US.UTF-8', 08:55:32 INFO - 'LANGUAGE': 'en_US:en', 08:55:32 INFO - 'LOGNAME': 'cltbld', 08:55:32 INFO - 'MAIL': '/var/mail/cltbld', 08:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:32 INFO - 'MOZ_NO_REMOTE': '1', 08:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:32 INFO - 'NO_EM_RESTART': '1', 08:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:32 INFO - 'PWD': '/builds/slave/test', 08:55:32 INFO - 'SHELL': '/bin/bash', 08:55:32 INFO - 'SHLVL': '1', 08:55:32 INFO - 'TERM': 'linux', 08:55:32 INFO - 'TMOUT': '86400', 08:55:32 INFO - 'USER': 'cltbld', 08:55:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:32 INFO - '_': '/tools/buildbot/bin/python'} 08:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:32 INFO - Running setup.py (path:/tmp/pip-YoUAX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:32 INFO - Running setup.py (path:/tmp/pip-kJhoJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:32 INFO - Running setup.py (path:/tmp/pip-Dm2sBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:32 INFO - Running setup.py (path:/tmp/pip-g69_uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:33 INFO - Running setup.py (path:/tmp/pip-ne_pFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:33 INFO - Running setup.py (path:/tmp/pip-F0yBAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:33 INFO - Running setup.py (path:/tmp/pip-4n_Lyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:33 INFO - Running setup.py (path:/tmp/pip-R999JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:33 INFO - Running setup.py (path:/tmp/pip-PsBtda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:33 INFO - Running setup.py (path:/tmp/pip-1f39uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:33 INFO - Running setup.py (path:/tmp/pip-hracz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:33 INFO - Running setup.py (path:/tmp/pip-eASNfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:33 INFO - Running setup.py (path:/tmp/pip-yrPFVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:33 INFO - Running setup.py (path:/tmp/pip-WLZo5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:33 INFO - Running setup.py (path:/tmp/pip-Cxe07f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:33 INFO - Running setup.py (path:/tmp/pip-oyCmBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:33 INFO - Running setup.py (path:/tmp/pip-0HbAGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:55:33 INFO - Running setup.py install for manifestparser 08:55:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for mozcrash 08:55:34 INFO - Running setup.py install for mozdebug 08:55:34 INFO - Running setup.py install for mozdevice 08:55:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for mozfile 08:55:34 INFO - Running setup.py install for mozhttpd 08:55:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for mozinfo 08:55:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for mozInstall 08:55:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for mozleak 08:55:34 INFO - Running setup.py install for mozlog 08:55:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:55:34 INFO - Running setup.py install for moznetwork 08:55:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Running setup.py install for mozprocess 08:55:35 INFO - Running setup.py install for mozprofile 08:55:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Running setup.py install for mozrunner 08:55:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Running setup.py install for mozscreenshot 08:55:35 INFO - Running setup.py install for moztest 08:55:35 INFO - Running setup.py install for mozversion 08:55:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:55:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:55:35 INFO - Cleaning up... 08:55:35 INFO - Return code: 0 08:55:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:35 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')]} 08:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:35 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')]} 08:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:35 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:35 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 08:55:35 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 08:55:35 INFO - Using env: {'DISPLAY': ':0', 08:55:35 INFO - 'HOME': '/home/cltbld', 08:55:35 INFO - 'LANG': 'en_US.UTF-8', 08:55:35 INFO - 'LANGUAGE': 'en_US:en', 08:55:35 INFO - 'LOGNAME': 'cltbld', 08:55:35 INFO - 'MAIL': '/var/mail/cltbld', 08:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:35 INFO - 'MOZ_NO_REMOTE': '1', 08:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:35 INFO - 'NO_EM_RESTART': '1', 08:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:35 INFO - 'PWD': '/builds/slave/test', 08:55:35 INFO - 'SHELL': '/bin/bash', 08:55:35 INFO - 'SHLVL': '1', 08:55:35 INFO - 'TERM': 'linux', 08:55:35 INFO - 'TMOUT': '86400', 08:55:35 INFO - 'USER': 'cltbld', 08:55:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:35 INFO - '_': '/tools/buildbot/bin/python'} 08:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:55:35 INFO - Running setup.py (path:/tmp/pip-klRrOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:55:35 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)) 08:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:55:36 INFO - Running setup.py (path:/tmp/pip-lKy2E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:55:36 INFO - Running setup.py (path:/tmp/pip-9E5mYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:55:36 INFO - Running setup.py (path:/tmp/pip-UdIuQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:55:36 INFO - Running setup.py (path:/tmp/pip-b8gLXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:55:36 INFO - Running setup.py (path:/tmp/pip-OSilY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:55:36 INFO - Running setup.py (path:/tmp/pip-6la6hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:55:36 INFO - Running setup.py (path:/tmp/pip-zgFcFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:55:36 INFO - Running setup.py (path:/tmp/pip-fPvsgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:55:36 INFO - Running setup.py (path:/tmp/pip-whxYAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:55:36 INFO - Running setup.py (path:/tmp/pip-fzYBS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:55:36 INFO - Running setup.py (path:/tmp/pip-YOpJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:55:36 INFO - Running setup.py (path:/tmp/pip-2NANrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:55:36 INFO - Running setup.py (path:/tmp/pip-Of6rvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:55:36 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)) 08:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:36 INFO - Running setup.py (path:/tmp/pip-G9y92l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:55:37 INFO - Running setup.py (path:/tmp/pip-X2_3Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:55:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:37 INFO - Running setup.py (path:/tmp/pip-9P521E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:55:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:39 INFO - Downloading blessings-1.6.tar.gz 08:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:39 INFO - Installing collected packages: blessings 08:55:39 INFO - Running setup.py install for blessings 08:55:39 INFO - Successfully installed blessings 08:55:39 INFO - Cleaning up... 08:55:39 INFO - Return code: 0 08:55:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:39 INFO - Reading from file tmpfile_stdout 08:55:39 INFO - Current package versions: 08:55:39 INFO - argparse == 1.2.1 08:55:39 INFO - blessings == 1.6 08:55:39 INFO - blobuploader == 1.2.4 08:55:39 INFO - docopt == 0.6.1 08:55:39 INFO - manifestparser == 1.1 08:55:39 INFO - mozInstall == 1.12 08:55:39 INFO - mozcrash == 0.17 08:55:39 INFO - mozdebug == 0.1 08:55:39 INFO - mozdevice == 0.48 08:55:39 INFO - mozfile == 1.2 08:55:39 INFO - mozhttpd == 0.7 08:55:39 INFO - mozinfo == 0.9 08:55:39 INFO - mozleak == 0.1 08:55:39 INFO - mozlog == 3.1 08:55:39 INFO - moznetwork == 0.27 08:55:39 INFO - mozprocess == 0.22 08:55:39 INFO - mozprofile == 0.28 08:55:39 INFO - mozrunner == 6.11 08:55:39 INFO - mozscreenshot == 0.1 08:55:39 INFO - mozsystemmonitor == 0.0 08:55:39 INFO - moztest == 0.7 08:55:39 INFO - mozversion == 1.4 08:55:39 INFO - psutil == 3.1.1 08:55:39 INFO - requests == 1.2.3 08:55:39 INFO - wsgiref == 0.1.2 08:55:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:39 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 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:39 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 08:55:39 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 08:55:39 INFO - Using env: {'DISPLAY': ':0', 08:55:39 INFO - 'HOME': '/home/cltbld', 08:55:39 INFO - 'LANG': 'en_US.UTF-8', 08:55:39 INFO - 'LANGUAGE': 'en_US:en', 08:55:39 INFO - 'LOGNAME': 'cltbld', 08:55:39 INFO - 'MAIL': '/var/mail/cltbld', 08:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:39 INFO - 'MOZ_NO_REMOTE': '1', 08:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:39 INFO - 'NO_EM_RESTART': '1', 08:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:39 INFO - 'PWD': '/builds/slave/test', 08:55:39 INFO - 'SHELL': '/bin/bash', 08:55:39 INFO - 'SHLVL': '1', 08:55:39 INFO - 'TERM': 'linux', 08:55:39 INFO - 'TMOUT': '86400', 08:55:39 INFO - 'USER': 'cltbld', 08:55:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:39 INFO - '_': '/tools/buildbot/bin/python'} 08:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 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)) 08:55:39 INFO - Cleaning up... 08:55:39 INFO - Return code: 0 08:55:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55: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')]} 08:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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')]} 08:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55: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', 'jsonschema'] in /builds/slave/test/build 08:55: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 jsonschema 08:55:39 INFO - Using env: {'DISPLAY': ':0', 08:55:39 INFO - 'HOME': '/home/cltbld', 08:55:39 INFO - 'LANG': 'en_US.UTF-8', 08:55:39 INFO - 'LANGUAGE': 'en_US:en', 08:55:39 INFO - 'LOGNAME': 'cltbld', 08:55:39 INFO - 'MAIL': '/var/mail/cltbld', 08:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:39 INFO - 'MOZ_NO_REMOTE': '1', 08:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:39 INFO - 'NO_EM_RESTART': '1', 08:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:39 INFO - 'PWD': '/builds/slave/test', 08:55:39 INFO - 'SHELL': '/bin/bash', 08:55:39 INFO - 'SHLVL': '1', 08:55:39 INFO - 'TERM': 'linux', 08:55:39 INFO - 'TMOUT': '86400', 08:55:39 INFO - 'USER': 'cltbld', 08:55:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:39 INFO - '_': '/tools/buildbot/bin/python'} 08:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:39 INFO - Downloading/unpacking jsonschema 08:55:39 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 08:55:39 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 08:55:39 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 08:55:39 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 08:55:39 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 08:55:39 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 08:55:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:55:41 INFO - Downloading/unpacking functools32 (from jsonschema) 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:42 INFO - Downloading functools32-3.2.3-2.tar.gz 08:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:55:42 INFO - warning: no files found matching '*.txt' 08:55:42 INFO - no previously-included directories found matching 'build' 08:55:42 INFO - no previously-included directories found matching 'dist' 08:55:42 INFO - no previously-included directories found matching '.git*' 08:55:42 INFO - Installing collected packages: jsonschema, functools32 08:55:42 INFO - Running setup.py install for functools32 08:55:42 INFO - warning: no files found matching '*.txt' 08:55:42 INFO - no previously-included directories found matching 'build' 08:55:42 INFO - no previously-included directories found matching 'dist' 08:55:42 INFO - no previously-included directories found matching '.git*' 08:55:42 INFO - Successfully installed jsonschema functools32 08:55:42 INFO - Cleaning up... 08:55:42 INFO - Return code: 0 08:55:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc36b294f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x178d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18585a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, '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': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', '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 08:55:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:55:42 INFO - Using env: {'DISPLAY': ':0', 08:55:42 INFO - 'HOME': '/home/cltbld', 08:55:42 INFO - 'LANG': 'en_US.UTF-8', 08:55:42 INFO - 'LANGUAGE': 'en_US:en', 08:55:42 INFO - 'LOGNAME': 'cltbld', 08:55:42 INFO - 'MAIL': '/var/mail/cltbld', 08:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:42 INFO - 'MOZ_NO_REMOTE': '1', 08:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:42 INFO - 'NO_EM_RESTART': '1', 08:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:42 INFO - 'PWD': '/builds/slave/test', 08:55:42 INFO - 'SHELL': '/bin/bash', 08:55:42 INFO - 'SHLVL': '1', 08:55:42 INFO - 'TERM': 'linux', 08:55:42 INFO - 'TMOUT': '86400', 08:55:42 INFO - 'USER': 'cltbld', 08:55:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:42 INFO - '_': '/tools/buildbot/bin/python'} 08:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:42 INFO - Downloading/unpacking flake8 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55: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 08:55:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:55:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:55:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:44 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 08:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:55:45 INFO - no previously-included directories found matching 'docs/_build' 08:55:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:55:45 INFO - Running setup.py install for pep8 08:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:55:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:55:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:55:45 INFO - no previously-included directories found matching 'docs/_build' 08:55:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:55:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:55:45 INFO - Cleaning up... 08:55:45 INFO - Return code: 0 08:55:45 INFO - Running post-action listener: _resource_record_post_action 08:55:45 INFO - Running post-action listener: _start_resource_monitoring 08:55:45 INFO - Starting resource monitoring. 08:55:45 INFO - ##### 08:55:45 INFO - ##### Running install step. 08:55:45 INFO - ##### 08:55:45 INFO - Running pre-action listener: _resource_record_pre_action 08:55:45 INFO - Running main action method: install 08:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:45 INFO - Reading from file tmpfile_stdout 08:55:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:45 INFO - Reading from file tmpfile_stdout 08:55:45 INFO - Output received: 08:55:45 INFO - Usage: mozinstall [options] installer 08:55:45 INFO - Options: 08:55:45 INFO - -h, --help show this help message and exit 08:55:45 INFO - -d DEST, --destination=DEST 08:55:45 INFO - Directory to install application into. [default: 08:55:45 INFO - "/builds/slave/test"] 08:55:45 INFO - --app=APP Application being installed. [default: firefox] 08:55:45 INFO - mkdir: /builds/slave/test/build/application 08:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:55:58 INFO - Reading from file tmpfile_stdout 08:55:58 INFO - Output received: 08:55:58 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:58 INFO - Running post-action listener: _resource_record_post_action 08:55:58 INFO - ##### 08:55:58 INFO - ##### Running run-tests step. 08:55:58 INFO - ##### 08:55:58 INFO - Running pre-action listener: _resource_record_pre_action 08:55:58 INFO - Running main action method: run_tests 08:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:58 INFO - Python 2.7.3 08:55:58 INFO - Return code: 0 08:55:58 INFO - grabbing minidump binary from tooltool 08:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:58 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 0x18e7410>, '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 0x18e8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:58 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 08:55:58 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 08:55:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:59 INFO - Return code: 0 08:55:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:55:59 INFO - Return code: 0 08:55:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 08:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 08:55:59 INFO - Using env: {'DISPLAY': ':0', 08:55:59 INFO - 'HOME': '/home/cltbld', 08:55:59 INFO - 'LANG': 'en_US.UTF-8', 08:55:59 INFO - 'LANGUAGE': 'en_US:en', 08:55:59 INFO - 'LOGNAME': 'cltbld', 08:55:59 INFO - 'MAIL': '/var/mail/cltbld', 08:55:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:59 INFO - 'MOZ_NO_REMOTE': '1', 08:55:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:59 INFO - 'NO_EM_RESTART': '1', 08:55:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:59 INFO - 'PWD': '/builds/slave/test', 08:55:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:59 INFO - 'SHELL': '/bin/bash', 08:55:59 INFO - 'SHLVL': '1', 08:55:59 INFO - 'TERM': 'linux', 08:55:59 INFO - 'TMOUT': '86400', 08:55:59 INFO - 'USER': 'cltbld', 08:55:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181', 08:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:59 INFO - '_': '/tools/buildbot/bin/python'} 08:55:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 08:56:00 INFO - mozversion application_buildid: 20160627060726 08:56:00 INFO - mozversion application_changeset: b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 08:56:00 INFO - mozversion application_display_name: Firefox 08:56:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:00 INFO - mozversion application_name: Firefox 08:56:00 INFO - mozversion application_remotingname: firefox 08:56:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:00 INFO - mozversion application_vendor: Mozilla 08:56:00 INFO - mozversion application_version: 48.0 08:56:00 INFO - mozversion platform_buildid: 20160627060726 08:56:00 INFO - mozversion platform_changeset: b7f4630c2e6451a400da7b7e1b5c1424ce0af1e2 08:56:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:00 INFO - mozversion platform_version: 48.0 08:56:00 INFO - using testdate: 1467042960 08:56:00 INFO - actual date: 1467042960 08:56:00 INFO - starting webserver on 'localhost:47266' 08:56:00 INFO - SUITE-START | Running 2 tests 08:56:00 INFO - TEST-START | dromaeo_css 08:56:00 INFO - operating with platform_type : linux_ 08:56:00 INFO - Initialising browser for dromaeo_css test... 08:56:00 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEuEHy/profile http://localhost:47266/getInfo.html) 08:56:03 INFO - PROCESS | 3584 | 08:56:03 INFO - PROCESS | 3584 | (process:3663): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:56:04 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 08:56:04 INFO - PROCESS | 3584 | colorDepth:24 08:56:04 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 08:56:04 INFO - PROCESS | 3584 | __metrics 08:56:04 ERROR - PROCESS | 3584 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:56:05 INFO - TEST-INFO | 3584: exit 0 08:56:05 INFO - Browser initialized. 08:56:05 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:05 INFO - TEST-INFO | started process 3714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXEuEHy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:07 INFO - PROCESS | 3714 | 08:56:07 INFO - PROCESS | 3714 | (process:3784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:56:17 INFO - PROCESS | 3714 | RSS: Main: 150310912 08:56:17 INFO - PROCESS | 3714 | 08:57:06 INFO - PROCESS | 3714 | 1467043026835 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] 08:59:14 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47266/tests/dromaeo/cssquery-ext.html) 08:59:15 INFO - PROCESS | 3714 | RSS: Main: 155594752 08:59:15 INFO - PROCESS | 3714 | 09:02:17 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-ext.html (next: http://localhost:47266/tests/dromaeo/cssquery-jquery.html) 09:02:18 INFO - PROCESS | 3714 | RSS: Main: 152485888 09:02:18 INFO - PROCESS | 3714 | 09:05:19 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47266/tests/dromaeo/cssquery-mootools.html) 09:05:20 INFO - PROCESS | 3714 | RSS: Main: 152064000 09:05:20 INFO - PROCESS | 3714 | 09:08:22 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47266/tests/dromaeo/cssquery-prototype.html) 09:08:22 INFO - PROCESS | 3714 | RSS: Main: 153747456 09:08:22 INFO - PROCESS | 3714 | 09:11:25 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47266/tests/dromaeo/cssquery-yui.html) 09:11:25 INFO - PROCESS | 3714 | RSS: Main: 151912448 09:11:25 INFO - PROCESS | 3714 | 09:14:27 INFO - PROCESS | 3714 | Cycle 1(1): loaded http://localhost:47266/tests/dromaeo/cssquery-yui.html (next: http://localhost:47266/tests/dromaeo/cssquery-dojo.html) 09:14:28 INFO - PROCESS | 3714 | RSS: Main: 155844608 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | __start_tp_report 09:14:28 INFO - PROCESS | 3714 | _x_x_mozilla_page_load 09:14:28 INFO - PROCESS | 3714 | _x_x_mozilla_page_load_details 09:14:28 INFO - PROCESS | 3714 | |i|pagename|runs| 09:14:28 INFO - PROCESS | 3714 | |0;dojo.html;3350.1289664687183;3456.1705190754196;3459.1352161959503;3509.964900350997;3520.559930008749;5690.5447564194865;5695.572832037598;5728.513076388512;5731.914021289684;5732.455416735409;5693.060644993581;5743.167240750089;5745.310562732468;5758.596898217126;5762.971185144069;5174.922376164351;5233.633645644806;5236.136037553799;5254.343207099113;5335.626506144571;5170.3020092287625;5235.345581802275;5374.838754837341;5383.81156659515;5393.81121660742;5215.4523775003645;5234.790608375661;5294.947050529503;5314.867128321804;5377.4084850666395;5303.920441193366;5305.257263983045;5315.813946511854;5318.601104917147;5328.813491527817;5047.621428392885;5144.459831717653;5208.5312321891215;5252.842414727565;5267.209918512215;5605.915911261334;5620.606557540974;5665.206871038058;5674.432556744334;5698.401667824902;6119.87760244797;6154.476869466101;6158.784442544535;6173.876522469525;6191.628502289832;6099.085137229406;6153.230846144232;6213;6221.346758590328;6252.062190671436;5760.510356619692;5788.131780232957;5793.188953546507;5811.506021988136;5843.152742852305;6314.589551679126;6317.526185536103;6326.968365158237;6332.271788744261;6335.429811317003;5957.582969192202;5978.730957106941;6048.243969503812;6059.818205453844;6072.423119803611;6112.711514445999;6116.698197749659;6122.550631082941;6132.41742034506;6141.63943600049;5975.52195824333;6101.786437474756;6104.38956104386;6120;6131.662758548234;5999.250093738283;6058.1518587397795;6119.755209791648;6124.2588809726185;6138.32709113608;4656.790444430008;4673.299005149255;4684.906301874012;4691.179043667345;4701.670883038223;4172.520160181557;4183.247015537232;4183.665306775511;4201.390798334224;4211.1998720243055;5682.914756278659;5885.823425297248;5928.199693041471;5946.345901950782;5975.551833612496;6058.242719660043;6106.2479184375725;6114.996965385541;6115.093588211903;6115.757578773014;5777.508911742549;5892.351841297454;5894.823155305347;5914.112883067574;5927.2590926134235;5225.320708307896;5264.078786212474;5267.051930652519;5290.5238528531845;5322.0154271459905;6436.35636436362;6442.291347951722;6476.5466417350335;6479.546431749826;6498.415142637091;5996.5502587305255;6082.270127584541;6265.74937002533;6268.62388256697;6278.681476889904;6238.563300568917;6238.844028899314;6252.1559589456665;6269.373062693694;6283.434490895841;5895.498882594856;5950.9404905952115;5962.165296858357;5963.4334738199805;5978.282606087298;5909.172715819703;6065.090236464565;6107.84730381744;6111.652512877656;6138.878900475427;6032.487238584594;6040.275166979991;6043.425874541911;6054.939450605438;6071.848203794941;5950.34546199909;6022.668753218615;6064;6070.089486576872;6078.118672792509;5785.884282314246;5888;5918;5944.346121926498;5997.610155339889;6078.149059131637;6086.847828804315;6108.297545782114;6116.235470566179;6134.570580059353;5938.703064846827;5953.642781433128;5953.821385358447;5961.7615295387695;5975.193348898017 09:14:28 INFO - PROCESS | 3714 | |1;ext.html;665.0024962556166;674.3593586093211;676.0096458688021;731.8426538294269;740.7851723000329;32477.188070298253;33346.833265833666;38953.220935581274;39458;39720.404193937116;42031;42496.78751606237;43134.78432607841;43144.56855431452;43158.35262471066;8744.519051452184;8907.287417006624;8926.2412694921;8933.642654293853;8950.955245223764;8776.69281575145;8911.064338244489;8917.33120015998;8963.775905602346;8969.641214351419;9120.817583648322;9178.495182764946;9181.127792859668;9186.54067296636;9189.540522973857;9177.77055573616;9180.036096209902;9213.493257870814;9225.584848681825;9232.815343693088;9039.683611073646;9171.58727857248;9178.128077832594;9193.54032298389;9201.769955751093;43535.78232108851;44150.33774493385;44591;44613.107737845065;44631;3683;3762.529683789526;3818.3508803503473;3838.596947320519;3960.1683646434285;34112.147196320046;34461.31077378438;34622.30755384903;34637;34836.477452838226;4235.53409124996;4260.829566817323;4320.870373888788;4330.653547716175;4363.672724545671;304906;308809;309581;310602.4469877659;310998;64165.35834641687;64647.67676161589;64815.35184648093;64883.67558162273;64949;70004.29995699978;70560;71321;71419.64290178516;71587.64206178936;17133.82866171322;17247.827521724874;17363.47909562715;17366.47900562985;17414.129293535272;12970.80543791844;13062.34688265602;13111.016673749507;13148.671283217805;13169.736605268032;21105.366838994854;21472.57054858894;21481.355559332933;21492.247771328242;21583.56832863334;7887.487313324616;7921.168277330912;8125.309348705308;8212.753617391489;8215.424920255644;1165.6211731187398;1171.77736230116;1185.0815617896199;1192.970175745596;1235.2711899979056;33870.32259354848;33927.32145357079;33952.32095358079;34003;34476.655233447345;1182.1665725663386;1261.5521489870964;1272.5037235478171;1314.4676406055562;1352.9255890925897;17730.29078836858;17883.28466861311;17910.5522361942;18006;18161.63676726458;468303;468304;471976;502906;511760;56521.71739141278;57147;57519.424805751405;57662.7116864413;57759.4224057754;1559.2515592515429;1586.8889177757676;1588.4043483693615;1596.0583255879087;1675.6229848284283;30725.92459263915;31071.067867963997;31194.68805311918;32070.67929320677;32081.67918320787;55585.722071389384;55910.72044639914;56096.71951640379;56193.15710264431;56278.1558276618;409094;411587;412538;413086;413146;31882.840585796923;32655.673443266212;32891;32930.5060424089;33181.33637327288;51864.48135518596;52100.739496302274;52489.16457910894;53021;53540.46459535355;43206.56793432151;43268;43293;43447.348289775044;44595;42468.78765606152;42881.35677964771;43419.782901085295;43478.56521434745;44141.33787993247;43633.781831090644;44676.32985505285;44969.100617986805;45212.54787452083;47768.761156194;36909;37024.62975370212;37066.654775528994;37640;37681;29153.56269655999;29806.70193298039;29995.850020749756;30043.54934675938;30351.544726829557 09:14:28 INFO - PROCESS | 3714 | |2;jquery.html;421.7975371821524;423.3691799219163;424.53937477836547;435.6797753651066;445.7370151610549;18796.906015469922;19092.427227183172;19516.90241548792;19525.99999999998;19932.302369417073;12685.175463594884;12785.424655890483;12911.289879056649;18566.35017774378;19172.616547669073;5305.124654432014;5447.727613619323;5451;5475.972620136914;5481.616286859921;5170.146925757245;5357.812476563321;5359.785608575652;5361.222622719703;5363.141897296433;5276.445973172819;5286.127788914824;5289.629725919187;5326.414094449608;5330.92003619946;5332.866678333054;5364.249005139283;5906.26171728534;5909.645421274738;5922.230110085661;5355.250264962909;5360.678359298416;5366.570674346043;5387.191921211849;5391.299131112969;13946.511872084428;22104.557908841733;22969.196078137353;23539.646905296435;23687.052517899265;2360;2445.29086564896;2528.089887640448;2638.7097419283864;2935.5890175375466;10827.729306767314;10985.560577576887;11183.720406989809;12381.938090309492;15111;2087.2485905074163;2116.5237821490196;2151.655735082379;2157.5037741319584;2180.661997390407;75807;78278.6086069566;80010;80784.19215807885;81061;11130.721731956766;11500.25248358854;11577.826332605018;11667.708307292216;11750.412479375997;16343.918280408521;16382.262798174112;16384.672306553803;16509.6698066038;16512.174391280387;8665.17680820321;8802.559872006374;8831.867521987175;8949.731508054769;8993.14565116313;8709.520976346235;8715.912840871637;8729.694460693845;8810.118988101138;8872.334574906909;4960.553550180501;5016.799328026838;5057.6459647824295;5060.3927528696795;5155.149400348901;2085.18677715691;2142.4750936020773;2156.827453803692;2169.8155656769036;2170.9782902170778;427.2672366890735;1016.4358780876537;1112.9387883666477;1188.2632767683917;1202.699325168708;11266;11807;11823.290602563873;11890.524379024915;11896.680147371353;466.97431641260056;468.91325104855713;476.10492274523676;476.4068734425662;483.7036741532656;6393.584417012879;6489;6520.739170433224;6552.672366381662;6656.933430665728;496929;507225;522937;526465;535480.6611142615;98314.5084274574;99104;100478.4976075115;100691.49654251682;101617;1132.937688427128;1178.0810967445407;1190.9166358354832;1192.3144192089583;1193.4390836307095;17139.571510712332;17179.57051073683;17241.39655112065;17439;17473.38843140484;34676.306473869874;35320.29359412849;35544;36141.63858361383;36698.8165059173;48462.5153748458;52301.47698522966;58769;59365;59784.402155979624;8713.738587842376;8823.117688231125;8837.779055523662;9143.679971200976;9163.129502697233;9851.064148905842;13201.07592468518;13641.727165456834;13875.72248555003;14038.578842634737;11971.221870578733;12165.270083795001;12235.265884046985;12314.322712250912;12463.5014599415;11900.16698831108;12002.579909703118;12008.279503229835;12120;12512.56206032821;12092.38522671353;12304.138710290552;12436.875631243573;12444.315562644142;12507.93746031264;8460.11168827289;8806.339524535813;8852.247558957302;8958.328125390492;9414.15272625467;9269.768255793659;11197.328160310408;11692.47383867711;11948.223365481563;11970.46132924038 09:14:28 INFO - PROCESS | 3714 | |3;mootools.html;1602.9038257704535;1604.101703046294;1844.5665268661862;1958.559324152067;1961.3331467301123;8045.074816396116;8672.30621550276;8710.869336959951;8942.642294308229;8969.103089691036;8686.391952563306;8768.824623507526;8788.077251888555;8962.193402593764;8992.055834137404;2444.05903727065;2445.119756887519;2465.6794616699804;2470.17249221511;2486.962695559568;2432.8418652787514;2532.050481069599;2533.3793220660964;2534.341071321451;2545.2491515003117;2463.187148241085;2466.4450498637843;2492.501499700067;2497.2008957133726;2497.3506888209013;2469.1481438903547;2491.576432006554;2495.1890635543523;2500.3374105861963;2502.2993561802723;2499.3751562109474;2512.032867346085;2515.6729625148796;2531.9113831015825;2533.9873300633562;9023.864642030374;9057.818843623156;9059.275257979345;9061.13919177677;9112.681056163003;5519.586031047687;5646.717664116778;5647.124695672177;5652.321721393418;5658.490735833753;3490.8080055596934;3506.579210494757;3535.7701749386206;3556.590992035923;3600.8019558924248;1110.5724296146043;1118.2507719827736;1120.2718233148437;1133.161460519218;1170.2218025013356;12686.682832929158;12749.362531873368;12805.423755931006;12813.423395947111;12816.743665126738;4569.360289559464;4588.7246765194195;4598.057398233354;4613.331066995267;4842.709437433765;10119.342242754197;10127.544260508295;10128.291019628556;10133.543990520444;10145.08694217524;5370.087085195526;5417.485338892799;5423.078076726966;5425.9186112208345;5436.293281873332;4482.327650852333;4926.359573255454;4941.43173535048;4950.108980383566;5014.623903207201;4014.41790940312;4200.243956087934;4204.894877628022;4211.936820947688;4251.319788833834;1215.8753153333132;1234.672811704881;1244.2472304255975;1249.500199920021;1257.836481257449;974.4153507895206;1049.968500944973;1070.801901648182;1072.8229842076125;1073.951672174754;6093.542984276197;6234.625922444578;6307.747690092437;6391.936080639134;6403.199600049994;468.09890959902054;469.25154378765814;475.3653872080742;1117.5250518529592;1120.9719757005978;3809.980950095232;3861.4593956846065;3865.8260378283044;3890.6692931100606;3962.227365663726;10876.782464350827;11303.830442543369;11366.886331136748;11368.090552755759;11401.828972565418;11059.502322395512;11228.831567526493;11236.157288203418;11251.324920504796;11267.211295209421;8495.702650407206;8663.047064822864;8706.434081784664;8809.515476648718;8816.250618697355;6195.938040619536;6256.436920676979;6261.843453913689;6262.1546091278915;6283.7800676976085;10030.49847507607;10031.849522257025;10281.897181028095;10315.638952636622;10330.070293673605;9438.150566449052;9747.415155090717;9954.303198776017;10449.425281609585;10497.895021049691;7587.165411804586;7758.06903171623;7796.4932279401655;7942.404319675932;8105.392095592736;8698.434601750865;8729.25801306896;8737.868931965899;8766.868496972678;8768.824623507622;7721.459497835098;7948.89358787267;7984.361251099782;8025.438219324825;8067.556284404414;7728.92271077282;7859.52842829432;7871.330936870201;7872;7879.330256928225;6930.272321406382;7051.294870513113;7084.929150708633;7087.114110736158;7091;5084.313617661568;5130.204818253177;5188.662736922088;5304.9469505306;5324.840254792362;5244.580433565382;5321.627486075938;5344.732763361739;5345.358556973188;5407.459254074561 09:14:28 INFO - PROCESS | 3714 | |4;prototype.html;325.47110944714836;332.1944285108614;337.47841276281997;340.5402706346432;342.141225523935;6552.475801935846;6592.373724496171;6644.402003819655;6809.897851532225;6833.5899846009215;6613.933860661392;6657.134572505567;6673.966630166855;6685.966570167155;6686.498512611549;5017.147084995541;5017.448080711137;5026.321446604717;5029.9748501257445;5038.093143234217;5037.571806396442;5038.168702164138;5043.571296439789;5048.899022019557;5049.3183420238165;4993.575546078588;5001.549860512553;5004.174311238641;5007.524285192901;5010.273510340999;4749.358836557055;4898.779554920002;4990.0019996000765;4997.200447928332;5005.949940500603;4176.415301857743;4204.894877628053;4213.251500627267;4213.410122582841;4217.219814334358;6368.745250189987;6371.872562548723;6371.96814015927;6372.235331760218;6387.361263873622;5700.201971723962;5708.1437784332265;5710.428957104298;5719.7140142992685;5720.771169153229;6880.277570855088;6889.586624802528;6894.862102757967;6972.407345375649;6981.476389270825;4517.683762136652;4656.767161641938;4664.696794708333;4668.11305851887;4690.226112691402;7126.322999315057;7250.166230883516;7256.2380950000015;7282.599457029861;7285.817854553678;4671.6262698984;4688.038952014829;4711;4723.976380118077;4733.763311834395;4713.528647135327;4747.738874361943;4748.6438517111355;4752.002079563261;4774.140654682191;5640.32316122068;5640.689762063126;5643.209950606918;5645.5483561314995;5649.096144616841;6833.180018397824;6999.580025198505;7003.7548685795755;7015.684294206773;7074.610896400644;1657.983420165783;1672.698914195432;1681.6552606715593;1684.814670386281;1688.729803231477;1072.6942821295893;1074.382230217628;1080.573173596425;1093.3986307530827;1094.715374002765;6578.901316480256;6606.636634985122;6625.536212465081;6631.933680663228;6655.0682904393425;7127.7148914042855;7140.143182818095;7142.5714457132735;7142.714291428389;7162.498625096193;6540.574862633914;6606.570572912841;6611.074449577063;6629.403353698191;6636.236832764197;3850.4416859555768;3887.203123359761;3889.9416508752392;3890.3386424307937;3901.122247494291;7392.926070739224;7591.62041897914;7704.730334438268;7708.614569271514;7718.53688778675;7510.924890751132;7518.812029699301;7533.962330188314;7543.358814500829;7548.056492938383;7654.2345765423015;7655.578943158069;7668.731594394169;7675.846483070307;7677.078750549969;7225.783226503213;7310;7330.083739532559;7346.816329591803;7353.411727061715;7232.349088582053;7232.385247254042;7234.16807067173;7242.746503872339;7244.275572442713;7616.276453736886;7627.923720762721;7640.197779233323;7668.463207575639;7686.423518236043;4809.182438985311;4859.343988561499;4862.5380588844;4862.6839255449695;4865.318855360181;7122.821929451805;7214.639268036683;7317.487775855639;7322.853542929218;7330.633468326456;7109.82225444368;7111.751088711871;7132.358087772125;7132.572045677276;7143.285671433023;7111.395531379891;7120.074390329224;7123.715051397886;7127.180374256819;7136.250693677089;6941.75703850383;6987.336203060701;6995.475339349671;6998.300169983165;7016.158061032709;6920.238773734985;7138.8215294615975;7172;7185.53294035886;7211.71153153868;6830.077939478306;6954.200266969363;6959.547629404073;6978.755743548952;7010.404115650227 09:14:28 INFO - PROCESS | 3714 | |5;yui.html;908.3868388837535;928.7353104365258;943.0381011368404;954.4941181173972;961.7643677299059;15090.924545377258;15182.696346073086;15361.07833529989;15402.460913868017;15431.537053888373;13286.867131328683;13377.13048651837;13394.59816205513;13412.46350145993;13429.529966451177;750.9249075092488;888.1917455115846;914.008300993423;918.6876462002917;921.3044151665483;917.3486824354716;921.6820197032014;922.6171138977317;923.9538023098818;928.1275600935134;965.8502932045544;973.2214228617113;973.3138137612966;974.4250891973734;975.2636759246759;962.821877952581;969.0793745941313;970.4177493503877;970.4856426094182;971.0629242780715;716.0762616225063;716.2300526933567;718.1705130574195;718.4755128755985;719.8740220461399;15409.537713868602;15446.768298475532;15475.380984760595;15477.458288959833;15494;14895.404183832741;15179.289435434273;15211.61970950724;15372.231388430646;15380.077195368314;11605.361705106216;11691.590794322157;11747.236429632132;11939.940300298444;12032.27806331623;4059;4125.216208920326;4213.978930105361;4236.301010333292;4245.448091748084;52096.73951630256;53528.73235633836;54402.72798636061;54428;54474.72762636201;11112.986329656713;11193.552257909592;11226.831597526043;11389.202755807013;11400.372979486043;20200.09099590522;20261.49346266355;20326.288579899632;20344.593108137753;20347.491312717302;8467.703630372907;8548.401611887108;8731.126887311346;8799.560021998874;8836.8674469883;4711.740854253049;4853.39332583427;4983;5020.824271150565;5074.619403544749;3464.168599536093;3517.718582513393;3521.9823900880333;3526.4886591444097;3528.329617372742;616.0666590115978;644.2751904107879;644.365300179323;647.0359164844442;649.2241771083604;828.9461185023075;843.1484200957077;853.1724227499316;867.6052396159732;876.0101085773035;9654.806903861883;9882.258830587734;9934.354266972623;10058.547365368577;10096.192304615613;762.9280860391159;775.9728409505753;826.5412695953684;841.3227351981591;849.4521033933079;4385.758783266951;4448.621867141329;4493.146302202571;4667.369905062841;4695.7886895089805;62727.6863615679;63135.6843215781;63477.365226347145;63611.681941589995;64452;55417;55505.44494555084;55582.444175558536;55723;57793;49986.750066249435;50786.23820642693;51062;51173;51382.22926656103;7491.775246742606;8048.034235891496;8921.955390223007;9215.262778977532;9297;37973.430398544595;38017;39027.41458878062;39341.2131757369;39660.80169599134;45112;50091.74954125206;50124.24813627725;53261;58152.41847581639;13397.12918660284;13590.388432520362;13747.862521374658;14119;14197.651223133786;14082.859171408154;14415.78376324377;14628.853711463174;14877.792772529529;14889.776653350425;13729.931350343184;13739.519116830863;13794.65513362174;13809.309534523434;14014.299285035911;13672.794908076587;13821.516246931309;13822.101563398346;13962.092463989808;14129.434822606981;13502.797458037941;13612.795808063085;13695.246761428218;13725.245111518563;13817.79273310881;11304.717382065513;11509;11601.651950441501;11922.284662920252;11933.284002959503;11644.88355116472;11661.183717139718;11736.823947640622;11885.22746021506;11917.642470725892 09:14:28 INFO - PROCESS | 3714 | __end_tp_report 09:14:28 INFO - PROCESS | 3714 | __start_cc_report 09:14:28 INFO - PROCESS | 3714 | _x_x_mozilla_cycle_collect,324 09:14:28 INFO - PROCESS | 3714 | __end_cc_report 09:14:28 INFO - PROCESS | 3714 | __startTimestamp1467044068094__endTimestamp 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | ------- Summary: start ------- 09:14:28 INFO - PROCESS | 3714 | Number of tests: 6 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#0] dojo.html Cycles:165 Average:5717.98 Median:5950.94 stddev:630.36 (10.6%) stddev-sans-first:604.30 09:14:28 INFO - PROCESS | 3714 | Values: 3350.1 3456.2 3459.1 3510.0 3520.6 5690.5 5695.6 5728.5 5731.9 5732.5 5693.1 5743.2 5745.3 5758.6 5763.0 5174.9 5233.6 5236.1 5254.3 5335.6 5170.3 5235.3 5374.8 5383.8 5393.8 5215.5 5234.8 5294.9 5314.9 5377.4 5303.9 5305.3 5315.8 5318.6 5328.8 5047.6 5144.5 5208.5 5252.8 5267.2 5605.9 5620.6 5665.2 5674.4 5698.4 6119.9 6154.5 6158.8 6173.9 6191.6 6099.1 6153.2 6213.0 6221.3 6252.1 5760.5 5788.1 5793.2 5811.5 5843.2 6314.6 6317.5 6327.0 6332.3 6335.4 5957.6 5978.7 6048.2 6059.8 6072.4 6112.7 6116.7 6122.6 6132.4 6141.6 5975.5 6101.8 6104.4 6120.0 6131.7 5999.3 6058.2 6119.8 6124.3 6138.3 4656.8 4673.3 4684.9 4691.2 4701.7 4172.5 4183.2 4183.7 4201.4 4211.2 5682.9 5885.8 5928.2 5946.3 5975.6 6058.2 6106.2 6115.0 6115.1 6115.8 5777.5 5892.4 5894.8 5914.1 5927.3 5225.3 5264.1 5267.1 5290.5 5322.0 6436.4 6442.3 6476.5 6479.5 6498.4 5996.6 6082.3 6265.7 6268.6 6278.7 6238.6 6238.8 6252.2 6269.4 6283.4 5895.5 5950.9 5962.2 5963.4 5978.3 5909.2 6065.1 6107.8 6111.7 6138.9 6032.5 6040.3 6043.4 6054.9 6071.8 5950.3 6022.7 6064.0 6070.1 6078.1 5785.9 5888.0 5918.0 5944.3 5997.6 6078.1 6086.8 6108.3 6116.2 6134.6 5938.7 5953.6 5953.8 5961.8 5975.2 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#1] ext.html Cycles:180 Average:58305.85 Median:43008.07 stddev:107775.14 (250.6%) stddev-sans-first:107990.58 09:14:28 INFO - PROCESS | 3714 | Values: 665.0 674.4 676.0 731.8 740.8 32477.2 33346.8 38953.2 39458.0 39720.4 42031.0 42496.8 43134.8 43144.6 43158.4 8744.5 8907.3 8926.2 8933.6 8951.0 8776.7 8911.1 8917.3 8963.8 8969.6 9120.8 9178.5 9181.1 9186.5 9189.5 9177.8 9180.0 9213.5 9225.6 9232.8 9039.7 9171.6 9178.1 9193.5 9201.8 43535.8 44150.3 44591.0 44613.1 44631.0 3683.0 3762.5 3818.4 3838.6 3960.2 34112.1 34461.3 34622.3 34637.0 34836.5 4235.5 4260.8 4320.9 4330.7 4363.7 304906.0 308809.0 309581.0 310602.4 310998.0 64165.4 64647.7 64815.4 64883.7 64949.0 70004.3 70560.0 71321.0 71419.6 71587.6 17133.8 17247.8 17363.5 17366.5 17414.1 12970.8 13062.3 13111.0 13148.7 13169.7 21105.4 21472.6 21481.4 21492.2 21583.6 7887.5 7921.2 8125.3 8212.8 8215.4 1165.6 1171.8 1185.1 1193.0 1235.3 33870.3 33927.3 33952.3 34003.0 34476.7 1182.2 1261.6 1272.5 1314.5 1352.9 17730.3 17883.3 17910.6 18006.0 18161.6 468303.0 468304.0 471976.0 502906.0 511760.0 56521.7 57147.0 57519.4 57662.7 57759.4 1559.3 1586.9 1588.4 1596.1 1675.6 30725.9 31071.1 31194.7 32070.7 32081.7 55585.7 55910.7 56096.7 56193.2 56278.2 409094.0 411587.0 412538.0 413086.0 413146.0 31882.8 32655.7 32891.0 32930.5 33181.3 51864.5 52100.7 52489.2 53021.0 53540.5 43206.6 43268.0 43293.0 43447.3 44595.0 42468.8 42881.4 43419.8 43478.6 44141.3 43633.8 44676.3 44969.1 45212.5 47768.8 36909.0 37024.6 37066.7 37640.0 37681.0 29153.6 29806.7 29995.9 30043.5 30351.5 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#2] jquery.html Cycles:180 Average:29396.84 Median:34998.30 stddev:85426.08 (244.1%) stddev-sans-first:85638.02 09:14:28 INFO - PROCESS | 3714 | Values: 421.8 423.4 424.5 435.7 445.7 18796.9 19092.4 19516.9 19526.0 19932.3 12685.2 12785.4 12911.3 18566.4 19172.6 5305.1 5447.7 5451.0 5476.0 5481.6 5170.1 5357.8 5359.8 5361.2 5363.1 5276.4 5286.1 5289.6 5326.4 5330.9 5332.9 5364.2 5906.3 5909.6 5922.2 5355.3 5360.7 5366.6 5387.2 5391.3 13946.5 22104.6 22969.2 23539.6 23687.1 2360.0 2445.3 2528.1 2638.7 2935.6 10827.7 10985.6 11183.7 12381.9 15111.0 2087.2 2116.5 2151.7 2157.5 2180.7 75807.0 78278.6 80010.0 80784.2 81061.0 11130.7 11500.3 11577.8 11667.7 11750.4 16343.9 16382.3 16384.7 16509.7 16512.2 8665.2 8802.6 8831.9 8949.7 8993.1 8709.5 8715.9 8729.7 8810.1 8872.3 4960.6 5016.8 5057.6 5060.4 5155.1 2085.2 2142.5 2156.8 2169.8 2171.0 427.3 1016.4 1112.9 1188.3 1202.7 11266.0 11807.0 11823.3 11890.5 11896.7 467.0 468.9 476.1 476.4 483.7 6393.6 6489.0 6520.7 6552.7 6656.9 496929.0 507225.0 522937.0 526465.0 535480.7 98314.5 99104.0 100478.5 100691.5 101617.0 1132.9 1178.1 1190.9 1192.3 1193.4 17139.6 17179.6 17241.4 17439.0 17473.4 34676.3 35320.3 35544.0 36141.6 36698.8 48462.5 52301.5 58769.0 59365.0 59784.4 8713.7 8823.1 8837.8 9143.7 9163.1 9851.1 13201.1 13641.7 13875.7 14038.6 11971.2 12165.3 12235.3 12314.3 12463.5 11900.2 12002.6 12008.3 12120.0 12512.6 12092.4 12304.1 12436.9 12444.3 12507.9 8460.1 8806.3 8852.2 8958.3 9414.2 9269.8 11197.3 11692.5 11948.2 11970.5 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#3] mootools.html Cycles:180 Average:5941.96 Median:4593.39 stddev:3341.04 (72.7%) stddev-sans-first:3334.50 09:14:28 INFO - PROCESS | 3714 | Values: 1602.9 1604.1 1844.6 1958.6 1961.3 8045.1 8672.3 8710.9 8942.6 8969.1 8686.4 8768.8 8788.1 8962.2 8992.1 2444.1 2445.1 2465.7 2470.2 2487.0 2432.8 2532.1 2533.4 2534.3 2545.2 2463.2 2466.4 2492.5 2497.2 2497.4 2469.1 2491.6 2495.2 2500.3 2502.3 2499.4 2512.0 2515.7 2531.9 2534.0 9023.9 9057.8 9059.3 9061.1 9112.7 5519.6 5646.7 5647.1 5652.3 5658.5 3490.8 3506.6 3535.8 3556.6 3600.8 1110.6 1118.3 1120.3 1133.2 1170.2 12686.7 12749.4 12805.4 12813.4 12816.7 4569.4 4588.7 4598.1 4613.3 4842.7 10119.3 10127.5 10128.3 10133.5 10145.1 5370.1 5417.5 5423.1 5425.9 5436.3 4482.3 4926.4 4941.4 4950.1 5014.6 4014.4 4200.2 4204.9 4211.9 4251.3 1215.9 1234.7 1244.2 1249.5 1257.8 974.4 1050.0 1070.8 1072.8 1074.0 6093.5 6234.6 6307.7 6391.9 6403.2 468.1 469.3 475.4 1117.5 1121.0 3810.0 3861.5 3865.8 3890.7 3962.2 10876.8 11303.8 11366.9 11368.1 11401.8 11059.5 11228.8 11236.2 11251.3 11267.2 8495.7 8663.0 8706.4 8809.5 8816.3 6195.9 6256.4 6261.8 6262.2 6283.8 10030.5 10031.8 10281.9 10315.6 10330.1 9438.2 9747.4 9954.3 10449.4 10497.9 7587.2 7758.1 7796.5 7942.4 8105.4 8698.4 8729.3 8737.9 8766.9 8768.8 7721.5 7948.9 7984.4 8025.4 8067.6 7728.9 7859.5 7871.3 7872.0 7879.3 6930.3 7051.3 7084.9 7087.1 7091.0 5084.3 5130.2 5188.7 5304.9 5324.8 5244.6 5321.6 5344.7 5345.4 5407.5 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#4] prototype.html Cycles:180 Average:5842.14 Median:6634.09 stddev:1830.25 (27.6%) stddev-sans-first:1787.93 09:14:28 INFO - PROCESS | 3714 | Values: 325.5 332.2 337.5 340.5 342.1 6552.5 6592.4 6644.4 6809.9 6833.6 6613.9 6657.1 6674.0 6686.0 6686.5 5017.1 5017.4 5026.3 5030.0 5038.1 5037.6 5038.2 5043.6 5048.9 5049.3 4993.6 5001.5 5004.2 5007.5 5010.3 4749.4 4898.8 4990.0 4997.2 5005.9 4176.4 4204.9 4213.3 4213.4 4217.2 6368.7 6371.9 6372.0 6372.2 6387.4 5700.2 5708.1 5710.4 5719.7 5720.8 6880.3 6889.6 6894.9 6972.4 6981.5 4517.7 4656.8 4664.7 4668.1 4690.2 7126.3 7250.2 7256.2 7282.6 7285.8 4671.6 4688.0 4711.0 4724.0 4733.8 4713.5 4747.7 4748.6 4752.0 4774.1 5640.3 5640.7 5643.2 5645.5 5649.1 6833.2 6999.6 7003.8 7015.7 7074.6 1658.0 1672.7 1681.7 1684.8 1688.7 1072.7 1074.4 1080.6 1093.4 1094.7 6578.9 6606.6 6625.5 6631.9 6655.1 7127.7 7140.1 7142.6 7142.7 7162.5 6540.6 6606.6 6611.1 6629.4 6636.2 3850.4 3887.2 3889.9 3890.3 3901.1 7392.9 7591.6 7704.7 7708.6 7718.5 7510.9 7518.8 7534.0 7543.4 7548.1 7654.2 7655.6 7668.7 7675.8 7677.1 7225.8 7310.0 7330.1 7346.8 7353.4 7232.3 7232.4 7234.2 7242.7 7244.3 7616.3 7627.9 7640.2 7668.5 7686.4 4809.2 4859.3 4862.5 4862.7 4865.3 7122.8 7214.6 7317.5 7322.9 7330.6 7109.8 7111.8 7132.4 7132.6 7143.3 7111.4 7120.1 7123.7 7127.2 7136.3 6941.8 6987.3 6995.5 6998.3 7016.2 6920.2 7138.8 7172.0 7185.5 7211.7 6830.1 6954.2 6959.5 6978.8 7010.4 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - PROCESS | 3714 | [#5] yui.html Cycles:180 Average:15617.96 Median:24889.68 stddev:17663.56 (71.0%) stddev-sans-first:17678.57 09:14:28 INFO - PROCESS | 3714 | Values: 908.4 928.7 943.0 954.5 961.8 15090.9 15182.7 15361.1 15402.5 15431.5 13286.9 13377.1 13394.6 13412.5 13429.5 750.9 888.2 914.0 918.7 921.3 917.3 921.7 922.6 924.0 928.1 965.9 973.2 973.3 974.4 975.3 962.8 969.1 970.4 970.5 971.1 716.1 716.2 718.2 718.5 719.9 15409.5 15446.8 15475.4 15477.5 15494.0 14895.4 15179.3 15211.6 15372.2 15380.1 11605.4 11691.6 11747.2 11939.9 12032.3 4059.0 4125.2 4214.0 4236.3 4245.4 52096.7 53528.7 54402.7 54428.0 54474.7 11113.0 11193.6 11226.8 11389.2 11400.4 20200.1 20261.5 20326.3 20344.6 20347.5 8467.7 8548.4 8731.1 8799.6 8836.9 4711.7 4853.4 4983.0 5020.8 5074.6 3464.2 3517.7 3522.0 3526.5 3528.3 616.1 644.3 644.4 647.0 649.2 828.9 843.1 853.2 867.6 876.0 9654.8 9882.3 9934.4 10058.5 10096.2 762.9 776.0 826.5 841.3 849.5 4385.8 4448.6 4493.1 4667.4 4695.8 62727.7 63135.7 63477.4 63611.7 64452.0 55417.0 55505.4 55582.4 55723.0 57793.0 49986.8 50786.2 51062.0 51173.0 51382.2 7491.8 8048.0 8922.0 9215.3 9297.0 37973.4 38017.0 39027.4 39341.2 39660.8 45112.0 50091.7 50124.2 53261.0 58152.4 13397.1 13590.4 13747.9 14119.0 14197.7 14082.9 14415.8 14628.9 14877.8 14889.8 13729.9 13739.5 13794.7 13809.3 14014.3 13672.8 13821.5 13822.1 13962.1 14129.4 13502.8 13612.8 13695.2 13725.2 13817.8 11304.7 11509.0 11601.7 11922.3 11933.3 11644.9 11661.2 11736.8 11885.2 11917.6 09:14:28 INFO - PROCESS | 3714 | -------- Summary: end -------- 09:14:28 INFO - PROCESS | 3714 | 09:14:28 INFO - TEST-INFO | 3714: exit 0 09:14:28 INFO - TEST-OK | dromaeo_css | took 1108642ms 09:14:28 INFO - TEST-START | kraken 09:14:28 INFO - operating with platform_type : linux_ 09:14:28 INFO - Initialising browser for kraken test... 09:14:28 INFO - TEST-INFO | started process 3960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Jb4l8/profile http://localhost:47266/getInfo.html) 09:14:32 INFO - PROCESS | 3960 | 09:14:32 INFO - PROCESS | 3960 | (process:4039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:14:32 INFO - PROCESS | 3960 | __metrics Screen width/height:1600/1200 09:14:32 INFO - PROCESS | 3960 | colorDepth:24 09:14:32 INFO - PROCESS | 3960 | Browser inner width/height: 1024/697 09:14:32 INFO - PROCESS | 3960 | __metrics 09:14:33 ERROR - PROCESS | 3960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:14:34 INFO - TEST-INFO | 3960: exit 0 09:14:34 INFO - Browser initialized. 09:14:34 INFO - Running cycle 1/1 for kraken test... 09:14:34 INFO - TEST-INFO | started process 4090 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Jb4l8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:35 INFO - PROCESS | 4090 | 09:14:35 INFO - PROCESS | 4090 | (process:4159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:14:45 INFO - PROCESS | 4090 | RSS: Main: 150884352 09:14:45 INFO - PROCESS | 4090 | 09:14:48 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47266/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:49 INFO - PROCESS | 4090 | RSS: Main: 156033024 09:14:49 INFO - PROCESS | 4090 | 09:14:51 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47266/tests/kraken/driver.html?testName=audio-dft) 09:14:52 INFO - PROCESS | 4090 | RSS: Main: 156028928 09:14:52 INFO - PROCESS | 4090 | 09:14:55 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47266/tests/kraken/driver.html?testName=audio-fft) 09:14:55 INFO - PROCESS | 4090 | RSS: Main: 156168192 09:14:55 INFO - PROCESS | 4090 | 09:14:57 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47266/tests/kraken/driver.html?testName=audio-oscillator) 09:14:58 INFO - PROCESS | 4090 | RSS: Main: 156078080 09:14:58 INFO - PROCESS | 4090 | 09:15:00 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:01 INFO - PROCESS | 4090 | RSS: Main: 155983872 09:15:01 INFO - PROCESS | 4090 | 09:15:04 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47266/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:04 INFO - PROCESS | 4090 | RSS: Main: 156282880 09:15:04 INFO - PROCESS | 4090 | 09:15:08 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47266/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:08 INFO - PROCESS | 4090 | RSS: Main: 156250112 09:15:08 INFO - PROCESS | 4090 | 09:15:11 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47266/tests/kraken/driver.html?testName=json-parse-financial) 09:15:12 INFO - PROCESS | 4090 | RSS: Main: 156667904 09:15:12 INFO - PROCESS | 4090 | 09:15:13 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:15:14 INFO - PROCESS | 4090 | RSS: Main: 156327936 09:15:14 INFO - PROCESS | 4090 | 09:15:16 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:15:16 INFO - PROCESS | 4090 | RSS: Main: 156225536 09:15:16 INFO - PROCESS | 4090 | 09:15:18 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:15:19 INFO - PROCESS | 4090 | RSS: Main: 156499968 09:15:19 INFO - PROCESS | 4090 | 09:15:21 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:15:22 INFO - PROCESS | 4090 | RSS: Main: 157106176 09:15:22 INFO - PROCESS | 4090 | 09:15:25 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:15:25 INFO - PROCESS | 4090 | RSS: Main: 157609984 09:15:25 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | Cycle 1(1): loaded http://localhost:47266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47266/tests/kraken/driver.html?testName=ai-astar) 09:15:27 INFO - PROCESS | 4090 | RSS: Main: 158429184 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | __start_tp_report 09:15:27 INFO - PROCESS | 4090 | _x_x_mozilla_page_load 09:15:27 INFO - PROCESS | 4090 | _x_x_mozilla_page_load_details 09:15:27 INFO - PROCESS | 4090 | |i|pagename|runs| 09:15:27 INFO - PROCESS | 4090 | |0;ai-astar;110;113;105;110;114;114;100;112;111;113 09:15:27 INFO - PROCESS | 4090 | |1;audio-beat-detection;152;130;159;171;129;154;152;126;194;132 09:15:27 INFO - PROCESS | 4090 | |2;audio-dft;161;164;165;162;162;163;163;162;163;163 09:15:27 INFO - PROCESS | 4090 | |3;audio-fft;76;77;75;163;76;76;74;74;175;76 09:15:27 INFO - PROCESS | 4090 | |4;audio-oscillator;94;93;149;92;92;94;146;92;93;149 09:15:27 INFO - PROCESS | 4090 | |5;imaging-gaussian-blur;120;117;117;117;117;117;117;118;117;117 09:15:27 INFO - PROCESS | 4090 | |6;imaging-darkroom;147;146;147;147;147;146;146;146;148;146 09:15:27 INFO - PROCESS | 4090 | |7;imaging-desaturate;95;95;94;96;95;95;95;94;95;95 09:15:27 INFO - PROCESS | 4090 | |8;json-parse-financial;54;55;57;55;58;56;61;74;54;53 09:15:27 INFO - PROCESS | 4090 | |9;json-stringify-tinderbox;58;60;60;59;58;59;59;58;58;59 09:15:27 INFO - PROCESS | 4090 | |10;stanford-crypto-aes;75;74;73;90;82;81;75;75;74;81 09:15:27 INFO - PROCESS | 4090 | |11;stanford-crypto-ccm;127;118;118;115;115;124;122;123;128;130 09:15:27 INFO - PROCESS | 4090 | |12;stanford-crypto-pbkdf2;162;166;159;165;163;162;166;160;163;167 09:15:27 INFO - PROCESS | 4090 | |13;stanford-crypto-sha256-iterative;68;72;68;67;66;69;68;66;65;66 09:15:27 INFO - PROCESS | 4090 | __end_tp_report 09:15:27 INFO - PROCESS | 4090 | __start_cc_report 09:15:27 INFO - PROCESS | 4090 | _x_x_mozilla_cycle_collect,844 09:15:27 INFO - PROCESS | 4090 | __end_cc_report 09:15:27 INFO - PROCESS | 4090 | __startTimestamp1467044127832__endTimestamp 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | ------- Summary: start ------- 09:15:27 INFO - PROCESS | 4090 | Number of tests: 14 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:4.47 (4.0%) stddev-sans-first:4.74 09:15:27 INFO - PROCESS | 4090 | Values: 110.0 113.0 105.0 110.0 114.0 114.0 100.0 112.0 111.0 113.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:153.00 stddev:21.66 (14.2%) stddev-sans-first:22.96 09:15:27 INFO - PROCESS | 4090 | Values: 152.0 130.0 159.0 171.0 129.0 154.0 152.0 126.0 194.0 132.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.00 09:15:27 INFO - PROCESS | 4090 | Values: 161.0 164.0 165.0 162.0 162.0 163.0 163.0 162.0 163.0 163.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:39.54 (52.0%) stddev-sans-first:41.38 09:15:27 INFO - PROCESS | 4090 | Values: 76.0 77.0 75.0 163.0 76.0 76.0 74.0 74.0 175.0 76.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:92.50 stddev:26.66 (28.8%) stddev-sans-first:27.69 09:15:27 INFO - PROCESS | 4090 | Values: 94.0 93.0 149.0 92.0 92.0 94.0 146.0 92.0 93.0 149.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:0.33 09:15:27 INFO - PROCESS | 4090 | Values: 120.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:15:27 INFO - PROCESS | 4090 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 148.0 146.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:15:27 INFO - PROCESS | 4090 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:56.50 stddev:6.18 (10.9%) stddev-sans-first:6.41 09:15:27 INFO - PROCESS | 4090 | Values: 54.0 55.0 57.0 55.0 58.0 56.0 61.0 74.0 54.0 53.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 09:15:27 INFO - PROCESS | 4090 | Values: 58.0 60.0 60.0 59.0 58.0 59.0 59.0 58.0 58.0 59.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:5.40 (6.9%) stddev-sans-first:5.61 09:15:27 INFO - PROCESS | 4090 | Values: 75.0 74.0 73.0 90.0 82.0 81.0 75.0 75.0 74.0 81.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.50 stddev:5.37 (4.4%) stddev-sans-first:5.39 09:15:27 INFO - PROCESS | 4090 | Values: 127.0 118.0 118.0 115.0 115.0 124.0 122.0 123.0 128.0 130.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:164.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 09:15:27 INFO - PROCESS | 4090 | Values: 162.0 166.0 159.0 165.0 163.0 162.0 166.0 160.0 163.0 167.0 09:15:27 INFO - PROCESS | 4090 | 09:15:27 INFO - PROCESS | 4090 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:2.13 09:15:27 INFO - PROCESS | 4090 | Values: 68.0 72.0 68.0 67.0 66.0 69.0 68.0 66.0 65.0 66.0 09:15:27 INFO - PROCESS | 4090 | -------- Summary: end -------- 09:15:27 INFO - PROCESS | 4090 | 09:15:28 INFO - TEST-INFO | 4090: exit 0 09:15:28 INFO - TEST-OK | kraken | took 59995ms 09:15:28 INFO - SUITE-END | took 1168s 09:15:28 INFO - Completed test suite (00:19:28) 09:15:28 INFO - javascript benchmark 09:15:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.1289664687183, 3456.1705190754196, 3459.1352161959503, 3509.964900350997, 3520.559930008749, 5690.5447564194865, 5695.572832037598, 5728.513076388512, 5731.914021289684, 5732.455416735409, 5693.060644993581, 5743.167240750089, 5745.310562732468, 5758.596898217126, 5762.971185144069, 5174.922376164351, 5233.633645644806, 5236.136037553799, 5254.343207099113, 5335.626506144571, 5170.3020092287625, 5235.345581802275, 5374.838754837341, 5383.81156659515, 5393.81121660742, 5215.4523775003645, 5234.790608375661, 5294.947050529503, 5314.867128321804, 5377.4084850666395, 5303.920441193366, 5305.257263983045, 5315.813946511854, 5318.601104917147, 5328.813491527817, 5047.621428392885, 5144.459831717653, 5208.5312321891215, 5252.842414727565, 5267.209918512215, 5605.915911261334, 5620.606557540974, 5665.206871038058, 5674.432556744334, 5698.401667824902, 6119.87760244797, 6154.476869466101, 6158.784442544535, 6173.876522469525, 6191.628502289832, 6099.085137229406, 6153.230846144232, 6213.0, 6221.346758590328, 6252.062190671436, 5760.510356619692, 5788.131780232957, 5793.188953546507, 5811.506021988136, 5843.152742852305, 6314.589551679126, 6317.526185536103, 6326.968365158237, 6332.271788744261, 6335.429811317003, 5957.582969192202, 5978.730957106941, 6048.243969503812, 6059.818205453844, 6072.423119803611, 6112.711514445999, 6116.698197749659, 6122.550631082941, 6132.41742034506, 6141.63943600049, 5975.52195824333, 6101.786437474756, 6104.38956104386, 6120.0, 6131.662758548234, 5999.250093738283, 6058.1518587397795, 6119.755209791648, 6124.2588809726185, 6138.32709113608, 4656.790444430008, 4673.299005149255, 4684.906301874012, 4691.179043667345, 4701.670883038223, 4172.520160181557, 4183.247015537232, 4183.665306775511, 4201.390798334224, 4211.1998720243055, 5682.914756278659, 5885.823425297248, 5928.199693041471, 5946.345901950782, 5975.551833612496, 6058.242719660043, 6106.2479184375725, 6114.996965385541, 6115.093588211903, 6115.757578773014, 5777.508911742549, 5892.351841297454, 5894.823155305347, 5914.112883067574, 5927.2590926134235, 5225.320708307896, 5264.078786212474, 5267.051930652519, 5290.5238528531845, 5322.0154271459905, 6436.35636436362, 6442.291347951722, 6476.5466417350335, 6479.546431749826, 6498.415142637091, 5996.5502587305255, 6082.270127584541, 6265.74937002533, 6268.62388256697, 6278.681476889904, 6238.563300568917, 6238.844028899314, 6252.1559589456665, 6269.373062693694, 6283.434490895841, 5895.498882594856, 5950.9404905952115, 5962.165296858357, 5963.4334738199805, 5978.282606087298, 5909.172715819703, 6065.090236464565, 6107.84730381744, 6111.652512877656, 6138.878900475427, 6032.487238584594, 6040.275166979991, 6043.425874541911, 6054.939450605438, 6071.848203794941, 5950.34546199909, 6022.668753218615, 6064.0, 6070.089486576872, 6078.118672792509, 5785.884282314246, 5888.0, 5918.0, 5944.346121926498, 5997.610155339889, 6078.149059131637, 6086.847828804315, 6108.297545782114, 6116.235470566179, 6134.570580059353, 5938.703064846827, 5953.642781433128, 5953.821385358447, 5961.7615295387695, 5975.193348898017], "value": 5677.190714355492, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.0024962556166, 674.3593586093211, 676.0096458688021, 731.8426538294269, 740.7851723000329, 32477.188070298253, 33346.833265833666, 38953.220935581274, 39458.0, 39720.404193937116, 42031.0, 42496.78751606237, 43134.78432607841, 43144.56855431452, 43158.35262471066, 8744.519051452184, 8907.287417006624, 8926.2412694921, 8933.642654293853, 8950.955245223764, 8776.69281575145, 8911.064338244489, 8917.33120015998, 8963.775905602346, 8969.641214351419, 9120.817583648322, 9178.495182764946, 9181.127792859668, 9186.54067296636, 9189.540522973857, 9177.77055573616, 9180.036096209902, 9213.493257870814, 9225.584848681825, 9232.815343693088, 9039.683611073646, 9171.58727857248, 9178.128077832594, 9193.54032298389, 9201.769955751093, 43535.78232108851, 44150.33774493385, 44591.0, 44613.107737845065, 44631.0, 3683.0, 3762.529683789526, 3818.3508803503473, 3838.596947320519, 3960.1683646434285, 34112.147196320046, 34461.31077378438, 34622.30755384903, 34637.0, 34836.477452838226, 4235.53409124996, 4260.829566817323, 4320.870373888788, 4330.653547716175, 4363.672724545671, 304906.0, 308809.0, 309581.0, 310602.4469877659, 310998.0, 64165.35834641687, 64647.67676161589, 64815.35184648093, 64883.67558162273, 64949.0, 70004.29995699978, 70560.0, 71321.0, 71419.64290178516, 71587.64206178936, 17133.82866171322, 17247.827521724874, 17363.47909562715, 17366.47900562985, 17414.129293535272, 12970.80543791844, 13062.34688265602, 13111.016673749507, 13148.671283217805, 13169.736605268032, 21105.366838994854, 21472.57054858894, 21481.355559332933, 21492.247771328242, 21583.56832863334, 7887.487313324616, 7921.168277330912, 8125.309348705308, 8212.753617391489, 8215.424920255644, 1165.6211731187398, 1171.77736230116, 1185.0815617896199, 1192.970175745596, 1235.2711899979056, 33870.32259354848, 33927.32145357079, 33952.32095358079, 34003.0, 34476.655233447345, 1182.1665725663386, 1261.5521489870964, 1272.5037235478171, 1314.4676406055562, 1352.9255890925897, 17730.29078836858, 17883.28466861311, 17910.5522361942, 18006.0, 18161.63676726458, 468303.0, 468304.0, 471976.0, 502906.0, 511760.0, 56521.71739141278, 57147.0, 57519.424805751405, 57662.7116864413, 57759.4224057754, 1559.2515592515429, 1586.8889177757676, 1588.4043483693615, 1596.0583255879087, 1675.6229848284283, 30725.92459263915, 31071.067867963997, 31194.68805311918, 32070.67929320677, 32081.67918320787, 55585.722071389384, 55910.72044639914, 56096.71951640379, 56193.15710264431, 56278.1558276618, 409094.0, 411587.0, 412538.0, 413086.0, 413146.0, 31882.840585796923, 32655.673443266212, 32891.0, 32930.5060424089, 33181.33637327288, 51864.48135518596, 52100.739496302274, 52489.16457910894, 53021.0, 53540.46459535355, 43206.56793432151, 43268.0, 43293.0, 43447.348289775044, 44595.0, 42468.78765606152, 42881.35677964771, 43419.782901085295, 43478.56521434745, 44141.33787993247, 43633.781831090644, 44676.32985505285, 44969.100617986805, 45212.54787452083, 47768.761156194, 36909.0, 37024.62975370212, 37066.654775528994, 37640.0, 37681.0, 29153.56269655999, 29806.70193298039, 29995.850020749756, 30043.54934675938, 30351.544726829557], "value": 21085.542833837313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.7975371821524, 423.3691799219163, 424.53937477836547, 435.6797753651066, 445.7370151610549, 18796.906015469922, 19092.427227183172, 19516.90241548792, 19525.99999999998, 19932.302369417073, 12685.175463594884, 12785.424655890483, 12911.289879056649, 18566.35017774378, 19172.616547669073, 5305.124654432014, 5447.727613619323, 5451.0, 5475.972620136914, 5481.616286859921, 5170.146925757245, 5357.812476563321, 5359.785608575652, 5361.222622719703, 5363.141897296433, 5276.445973172819, 5286.127788914824, 5289.629725919187, 5326.414094449608, 5330.92003619946, 5332.866678333054, 5364.249005139283, 5906.26171728534, 5909.645421274738, 5922.230110085661, 5355.250264962909, 5360.678359298416, 5366.570674346043, 5387.191921211849, 5391.299131112969, 13946.511872084428, 22104.557908841733, 22969.196078137353, 23539.646905296435, 23687.052517899265, 2360.0, 2445.29086564896, 2528.089887640448, 2638.7097419283864, 2935.5890175375466, 10827.729306767314, 10985.560577576887, 11183.720406989809, 12381.938090309492, 15111.0, 2087.2485905074163, 2116.5237821490196, 2151.655735082379, 2157.5037741319584, 2180.661997390407, 75807.0, 78278.6086069566, 80010.0, 80784.19215807885, 81061.0, 11130.721731956766, 11500.25248358854, 11577.826332605018, 11667.708307292216, 11750.412479375997, 16343.918280408521, 16382.262798174112, 16384.672306553803, 16509.6698066038, 16512.174391280387, 8665.17680820321, 8802.559872006374, 8831.867521987175, 8949.731508054769, 8993.14565116313, 8709.520976346235, 8715.912840871637, 8729.694460693845, 8810.118988101138, 8872.334574906909, 4960.553550180501, 5016.799328026838, 5057.6459647824295, 5060.3927528696795, 5155.149400348901, 2085.18677715691, 2142.4750936020773, 2156.827453803692, 2169.8155656769036, 2170.9782902170778, 427.2672366890735, 1016.4358780876537, 1112.9387883666477, 1188.2632767683917, 1202.699325168708, 11266.0, 11807.0, 11823.290602563873, 11890.524379024915, 11896.680147371353, 466.97431641260056, 468.91325104855713, 476.10492274523676, 476.4068734425662, 483.7036741532656, 6393.584417012879, 6489.0, 6520.739170433224, 6552.672366381662, 6656.933430665728, 496929.0, 507225.0, 522937.0, 526465.0, 535480.6611142615, 98314.5084274574, 99104.0, 100478.4976075115, 100691.49654251682, 101617.0, 1132.937688427128, 1178.0810967445407, 1190.9166358354832, 1192.3144192089583, 1193.4390836307095, 17139.571510712332, 17179.57051073683, 17241.39655112065, 17439.0, 17473.38843140484, 34676.306473869874, 35320.29359412849, 35544.0, 36141.63858361383, 36698.8165059173, 48462.5153748458, 52301.47698522966, 58769.0, 59365.0, 59784.402155979624, 8713.738587842376, 8823.117688231125, 8837.779055523662, 9143.679971200976, 9163.129502697233, 9851.064148905842, 13201.07592468518, 13641.727165456834, 13875.72248555003, 14038.578842634737, 11971.221870578733, 12165.270083795001, 12235.265884046985, 12314.322712250912, 12463.5014599415, 11900.16698831108, 12002.579909703118, 12008.279503229835, 12120.0, 12512.56206032821, 12092.38522671353, 12304.138710290552, 12436.875631243573, 12444.315562644142, 12507.93746031264, 8460.11168827289, 8806.339524535813, 8852.247558957302, 8958.328125390492, 9414.15272625467, 9269.768255793659, 11197.328160310408, 11692.47383867711, 11948.223365481563, 11970.46132924038], "value": 8929.922931019477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1602.9038257704535, 1604.101703046294, 1844.5665268661862, 1958.559324152067, 1961.3331467301123, 8045.074816396116, 8672.30621550276, 8710.869336959951, 8942.642294308229, 8969.103089691036, 8686.391952563306, 8768.824623507526, 8788.077251888555, 8962.193402593764, 8992.055834137404, 2444.05903727065, 2445.119756887519, 2465.6794616699804, 2470.17249221511, 2486.962695559568, 2432.8418652787514, 2532.050481069599, 2533.3793220660964, 2534.341071321451, 2545.2491515003117, 2463.187148241085, 2466.4450498637843, 2492.501499700067, 2497.2008957133726, 2497.3506888209013, 2469.1481438903547, 2491.576432006554, 2495.1890635543523, 2500.3374105861963, 2502.2993561802723, 2499.3751562109474, 2512.032867346085, 2515.6729625148796, 2531.9113831015825, 2533.9873300633562, 9023.864642030374, 9057.818843623156, 9059.275257979345, 9061.13919177677, 9112.681056163003, 5519.586031047687, 5646.717664116778, 5647.124695672177, 5652.321721393418, 5658.490735833753, 3490.8080055596934, 3506.579210494757, 3535.7701749386206, 3556.590992035923, 3600.8019558924248, 1110.5724296146043, 1118.2507719827736, 1120.2718233148437, 1133.161460519218, 1170.2218025013356, 12686.682832929158, 12749.362531873368, 12805.423755931006, 12813.423395947111, 12816.743665126738, 4569.360289559464, 4588.7246765194195, 4598.057398233354, 4613.331066995267, 4842.709437433765, 10119.342242754197, 10127.544260508295, 10128.291019628556, 10133.543990520444, 10145.08694217524, 5370.087085195526, 5417.485338892799, 5423.078076726966, 5425.9186112208345, 5436.293281873332, 4482.327650852333, 4926.359573255454, 4941.43173535048, 4950.108980383566, 5014.623903207201, 4014.41790940312, 4200.243956087934, 4204.894877628022, 4211.936820947688, 4251.319788833834, 1215.8753153333132, 1234.672811704881, 1244.2472304255975, 1249.500199920021, 1257.836481257449, 974.4153507895206, 1049.968500944973, 1070.801901648182, 1072.8229842076125, 1073.951672174754, 6093.542984276197, 6234.625922444578, 6307.747690092437, 6391.936080639134, 6403.199600049994, 468.09890959902054, 469.25154378765814, 475.3653872080742, 1117.5250518529592, 1120.9719757005978, 3809.980950095232, 3861.4593956846065, 3865.8260378283044, 3890.6692931100606, 3962.227365663726, 10876.782464350827, 11303.830442543369, 11366.886331136748, 11368.090552755759, 11401.828972565418, 11059.502322395512, 11228.831567526493, 11236.157288203418, 11251.324920504796, 11267.211295209421, 8495.702650407206, 8663.047064822864, 8706.434081784664, 8809.515476648718, 8816.250618697355, 6195.938040619536, 6256.436920676979, 6261.843453913689, 6262.1546091278915, 6283.7800676976085, 10030.49847507607, 10031.849522257025, 10281.897181028095, 10315.638952636622, 10330.070293673605, 9438.150566449052, 9747.415155090717, 9954.303198776017, 10449.425281609585, 10497.895021049691, 7587.165411804586, 7758.06903171623, 7796.4932279401655, 7942.404319675932, 8105.392095592736, 8698.434601750865, 8729.25801306896, 8737.868931965899, 8766.868496972678, 8768.824623507622, 7721.459497835098, 7948.89358787267, 7984.361251099782, 8025.438219324825, 8067.556284404414, 7728.92271077282, 7859.52842829432, 7871.330936870201, 7872.0, 7879.330256928225, 6930.272321406382, 7051.294870513113, 7084.929150708633, 7087.114110736158, 7091.0, 5084.313617661568, 5130.204818253177, 5188.662736922088, 5304.9469505306, 5324.840254792362, 5244.580433565382, 5321.627486075938, 5344.732763361739, 5345.358556973188, 5407.459254074561], "value": 4757.691148123984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.47110944714836, 332.1944285108614, 337.47841276281997, 340.5402706346432, 342.141225523935, 6552.475801935846, 6592.373724496171, 6644.402003819655, 6809.897851532225, 6833.5899846009215, 6613.933860661392, 6657.134572505567, 6673.966630166855, 6685.966570167155, 6686.498512611549, 5017.147084995541, 5017.448080711137, 5026.321446604717, 5029.9748501257445, 5038.093143234217, 5037.571806396442, 5038.168702164138, 5043.571296439789, 5048.899022019557, 5049.3183420238165, 4993.575546078588, 5001.549860512553, 5004.174311238641, 5007.524285192901, 5010.273510340999, 4749.358836557055, 4898.779554920002, 4990.0019996000765, 4997.200447928332, 5005.949940500603, 4176.415301857743, 4204.894877628053, 4213.251500627267, 4213.410122582841, 4217.219814334358, 6368.745250189987, 6371.872562548723, 6371.96814015927, 6372.235331760218, 6387.361263873622, 5700.201971723962, 5708.1437784332265, 5710.428957104298, 5719.7140142992685, 5720.771169153229, 6880.277570855088, 6889.586624802528, 6894.862102757967, 6972.407345375649, 6981.476389270825, 4517.683762136652, 4656.767161641938, 4664.696794708333, 4668.11305851887, 4690.226112691402, 7126.322999315057, 7250.166230883516, 7256.2380950000015, 7282.599457029861, 7285.817854553678, 4671.6262698984, 4688.038952014829, 4711.0, 4723.976380118077, 4733.763311834395, 4713.528647135327, 4747.738874361943, 4748.6438517111355, 4752.002079563261, 4774.140654682191, 5640.32316122068, 5640.689762063126, 5643.209950606918, 5645.5483561314995, 5649.096144616841, 6833.180018397824, 6999.580025198505, 7003.7548685795755, 7015.684294206773, 7074.610896400644, 1657.983420165783, 1672.698914195432, 1681.6552606715593, 1684.814670386281, 1688.729803231477, 1072.6942821295893, 1074.382230217628, 1080.573173596425, 1093.3986307530827, 1094.715374002765, 6578.901316480256, 6606.636634985122, 6625.536212465081, 6631.933680663228, 6655.0682904393425, 7127.7148914042855, 7140.143182818095, 7142.5714457132735, 7142.714291428389, 7162.498625096193, 6540.574862633914, 6606.570572912841, 6611.074449577063, 6629.403353698191, 6636.236832764197, 3850.4416859555768, 3887.203123359761, 3889.9416508752392, 3890.3386424307937, 3901.122247494291, 7392.926070739224, 7591.62041897914, 7704.730334438268, 7708.614569271514, 7718.53688778675, 7510.924890751132, 7518.812029699301, 7533.962330188314, 7543.358814500829, 7548.056492938383, 7654.2345765423015, 7655.578943158069, 7668.731594394169, 7675.846483070307, 7677.078750549969, 7225.783226503213, 7310.0, 7330.083739532559, 7346.816329591803, 7353.411727061715, 7232.349088582053, 7232.385247254042, 7234.16807067173, 7242.746503872339, 7244.275572442713, 7616.276453736886, 7627.923720762721, 7640.197779233323, 7668.463207575639, 7686.423518236043, 4809.182438985311, 4859.343988561499, 4862.5380588844, 4862.6839255449695, 4865.318855360181, 7122.821929451805, 7214.639268036683, 7317.487775855639, 7322.853542929218, 7330.633468326456, 7109.82225444368, 7111.751088711871, 7132.358087772125, 7132.572045677276, 7143.285671433023, 7111.395531379891, 7120.074390329224, 7123.715051397886, 7127.180374256819, 7136.250693677089, 6941.75703850383, 6987.336203060701, 6995.475339349671, 6998.300169983165, 7016.158061032709, 6920.238773734985, 7138.8215294615975, 7172.0, 7185.53294035886, 7211.71153153868, 6830.077939478306, 6954.200266969363, 6959.547629404073, 6978.755743548952, 7010.404115650227], "value": 5225.839289535798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.3868388837535, 928.7353104365258, 943.0381011368404, 954.4941181173972, 961.7643677299059, 15090.924545377258, 15182.696346073086, 15361.07833529989, 15402.460913868017, 15431.537053888373, 13286.867131328683, 13377.13048651837, 13394.59816205513, 13412.46350145993, 13429.529966451177, 750.9249075092488, 888.1917455115846, 914.008300993423, 918.6876462002917, 921.3044151665483, 917.3486824354716, 921.6820197032014, 922.6171138977317, 923.9538023098818, 928.1275600935134, 965.8502932045544, 973.2214228617113, 973.3138137612966, 974.4250891973734, 975.2636759246759, 962.821877952581, 969.0793745941313, 970.4177493503877, 970.4856426094182, 971.0629242780715, 716.0762616225063, 716.2300526933567, 718.1705130574195, 718.4755128755985, 719.8740220461399, 15409.537713868602, 15446.768298475532, 15475.380984760595, 15477.458288959833, 15494.0, 14895.404183832741, 15179.289435434273, 15211.61970950724, 15372.231388430646, 15380.077195368314, 11605.361705106216, 11691.590794322157, 11747.236429632132, 11939.940300298444, 12032.27806331623, 4059.0, 4125.216208920326, 4213.978930105361, 4236.301010333292, 4245.448091748084, 52096.73951630256, 53528.73235633836, 54402.72798636061, 54428.0, 54474.72762636201, 11112.986329656713, 11193.552257909592, 11226.831597526043, 11389.202755807013, 11400.372979486043, 20200.09099590522, 20261.49346266355, 20326.288579899632, 20344.593108137753, 20347.491312717302, 8467.703630372907, 8548.401611887108, 8731.126887311346, 8799.560021998874, 8836.8674469883, 4711.740854253049, 4853.39332583427, 4983.0, 5020.824271150565, 5074.619403544749, 3464.168599536093, 3517.718582513393, 3521.9823900880333, 3526.4886591444097, 3528.329617372742, 616.0666590115978, 644.2751904107879, 644.365300179323, 647.0359164844442, 649.2241771083604, 828.9461185023075, 843.1484200957077, 853.1724227499316, 867.6052396159732, 876.0101085773035, 9654.806903861883, 9882.258830587734, 9934.354266972623, 10058.547365368577, 10096.192304615613, 762.9280860391159, 775.9728409505753, 826.5412695953684, 841.3227351981591, 849.4521033933079, 4385.758783266951, 4448.621867141329, 4493.146302202571, 4667.369905062841, 4695.7886895089805, 62727.6863615679, 63135.6843215781, 63477.365226347145, 63611.681941589995, 64452.0, 55417.0, 55505.44494555084, 55582.444175558536, 55723.0, 57793.0, 49986.750066249435, 50786.23820642693, 51062.0, 51173.0, 51382.22926656103, 7491.775246742606, 8048.034235891496, 8921.955390223007, 9215.262778977532, 9297.0, 37973.430398544595, 38017.0, 39027.41458878062, 39341.2131757369, 39660.80169599134, 45112.0, 50091.74954125206, 50124.24813627725, 53261.0, 58152.41847581639, 13397.12918660284, 13590.388432520362, 13747.862521374658, 14119.0, 14197.651223133786, 14082.859171408154, 14415.78376324377, 14628.853711463174, 14877.792772529529, 14889.776653350425, 13729.931350343184, 13739.519116830863, 13794.65513362174, 13809.309534523434, 14014.299285035911, 13672.794908076587, 13821.516246931309, 13822.101563398346, 13962.092463989808, 14129.434822606981, 13502.797458037941, 13612.795808063085, 13695.246761428218, 13725.245111518563, 13817.79273310881, 11304.717382065513, 11509.0, 11601.651950441501, 11922.284662920252, 11933.284002959503, 11644.88355116472, 11661.183717139718, 11736.823947640622, 11885.22746021506, 11917.642470725892], "value": 7266.635401798697, "unit": "score"}], "name": "dromaeo_css", "value": 7602.93827471752, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 105.0, 110.0, 114.0, 114.0, 100.0, 112.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 159.0, 171.0, 129.0, 154.0, 152.0, 126.0, 194.0, 132.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 165.0, 162.0, 162.0, 163.0, 163.0, 162.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 163.0, 76.0, 76.0, 74.0, 74.0, 175.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 149.0, 92.0, 92.0, 94.0, 146.0, 92.0, 93.0, 149.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 55.0, 58.0, 56.0, 61.0, 74.0, 54.0, 53.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 90.0, 82.0, 81.0, 75.0, 75.0, 74.0, 81.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 118.0, 115.0, 115.0, 124.0, 122.0, 123.0, 128.0, 130.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 159.0, 165.0, 163.0, 162.0, 166.0, 160.0, 163.0, 167.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 67.0, 66.0, 69.0, 68.0, 66.0, 65.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1532.6999999999998, "alertThreshold": 2.0}]} 09:15:29 INFO - Return code: 0 09:15:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:15:29 ERROR - # TBPL SUCCESS # 09:15:29 INFO - Running post-action listener: _resource_record_post_action 09:15:29 INFO - Running post-run listener: _resource_record_post_run 09:15:30 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 465571840; Read time: 12; Write time: 339796 09:15:30 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241836032; Read time: 0; Write time: 212336 09:15:30 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223735808; Read time: 12; Write time: 127460 09:15:30 INFO - Running post-run listener: _upload_blobber_files 09:15:30 INFO - Blob upload gear active. 09:15:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:30 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 09:15:30 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:15:30 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:15:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:15:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:15:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:31 INFO - (blobuploader) - INFO - Done attempting. 09:15:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:15:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:32 INFO - (blobuploader) - INFO - Done attempting. 09:15:32 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:32 INFO - Return code: 0 09:15:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf2378ffe58335196769070d6dda137196e71f4f9904dfb54dfdd4e2cd1f5598a382382b1406a70e6119a0e913decebc4eff619434e9162f3a3aaaf815a6794a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d016e535aa7f72d92dcbfb98f98df7ad0266827877c575f6e6385dc43894eedc6846d7c338f5a56308b179885d9f3fbad591a62c2ef19a9f5431ca576ff5ee"} 09:15:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:32 INFO - Contents: 09:15:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf2378ffe58335196769070d6dda137196e71f4f9904dfb54dfdd4e2cd1f5598a382382b1406a70e6119a0e913decebc4eff619434e9162f3a3aaaf815a6794a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d016e535aa7f72d92dcbfb98f98df7ad0266827877c575f6e6385dc43894eedc6846d7c338f5a56308b179885d9f3fbad591a62c2ef19a9f5431ca576ff5ee"} 09:15:32 INFO - Running post-run listener: copy_logs_to_upload_dir 09:15:32 INFO - Copying logs to upload dir... 09:15:32 INFO - mkdir: /builds/slave/test/build/upload/logs 09:15:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.481772 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-27 09:15:32.108986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:15:32.112522) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 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/Mozilla-Beta/sha512/bf2378ffe58335196769070d6dda137196e71f4f9904dfb54dfdd4e2cd1f5598a382382b1406a70e6119a0e913decebc4eff619434e9162f3a3aaaf815a6794a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d016e535aa7f72d92dcbfb98f98df7ad0266827877c575f6e6385dc43894eedc6846d7c338f5a56308b179885d9f3fbad591a62c2ef19a9f5431ca576ff5ee"} build_url:https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/EEK2csmGSGCW5ZI4e5HZCg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf2378ffe58335196769070d6dda137196e71f4f9904dfb54dfdd4e2cd1f5598a382382b1406a70e6119a0e913decebc4eff619434e9162f3a3aaaf815a6794a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d016e535aa7f72d92dcbfb98f98df7ad0266827877c575f6e6385dc43894eedc6846d7c338f5a56308b179885d9f3fbad591a62c2ef19a9f5431ca576ff5ee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:15:32.138667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:15:32.139051) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467042719.818687-588432181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:15:32.223486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:15:32.223955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:15:32.224438) ========= ========= Total master_lag: 0.19 =========