builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1466701883.46 results: success (0) buildid: 20160623070025 builduid: 8b901f1499614f4a80124dd39a4d350d revision: 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.458067) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.458562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.458901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.473820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.474155) ========= 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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 10:11:23-- 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% 135K=0.09s 2016-06-23 10:11:23 (135 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.669048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.669407) ========= 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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:23.718886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:11:23.719320) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 --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 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 --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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 10:11:23,929 truncating revision to first 12 chars 2016-06-23 10:11:23,929 Setting DEBUG logging. 2016-06-23 10:11:23,929 attempt 1/10 2016-06-23 10:11:23,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/427f987a10ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 10:11:24,548 unpacking tar archive at: mozilla-beta-427f987a10ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:11:24.730229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:24.730656) ========= script_repo_revision: 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:24.731134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:24.731497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:11:24.741714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 20 secs) (at 2016-06-23 10:11:24.742024) ========= /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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:25 INFO - MultiFileLogger online at 20160623 10:11:25 in /builds/slave/test 10:11:25 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 10:11:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:25 INFO - {'append_to_log': False, 10:11:25 INFO - 'base_work_dir': '/builds/slave/test', 10:11:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:11:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:25 INFO - 'branch': 'Mozilla-Beta', 10:11:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:25 INFO - 'config_files': ('talos/linux_config.py',), 10:11:25 INFO - 'default_actions': ('clobber', 10:11:25 INFO - 'read-buildbot-config', 10:11:25 INFO - 'download-and-extract', 10:11:25 INFO - 'populate-webroot', 10:11:25 INFO - 'create-virtualenv', 10:11:25 INFO - 'install', 10:11:25 INFO - 'run-tests'), 10:11:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:25 INFO - 'download_minidump_stackwalk': True, 10:11:25 INFO - 'download_symbols': 'ondemand', 10:11:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:25 INFO - 'installer_path': 'installer.exe', 10:11:25 INFO - 'log_level': 'info', 10:11:25 INFO - 'log_name': 'talos', 10:11:25 INFO - 'log_to_console': True, 10:11:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:25 INFO - 'opt_config_files': (), 10:11:25 INFO - 'pip_index': False, 10:11:25 INFO - 'sps_profile': False, 10:11:25 INFO - 'sps_profile_interval': 0, 10:11:25 INFO - 'suite': 'dromaeojs-e10s', 10:11:25 INFO - 'system_bits': '32', 10:11:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:25 INFO - 'title': 'talos-linux64-ix-027', 10:11:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:25 INFO - 'use_talos_json': True, 10:11:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:25 INFO - 'work_dir': 'build'} 10:11:25 INFO - ##### 10:11:25 INFO - ##### Running clobber step. 10:11:25 INFO - ##### 10:11:25 INFO - Running pre-action listener: _resource_record_pre_action 10:11:25 INFO - Running main action method: clobber 10:11:25 INFO - rmtree: /builds/slave/test/build 10:11:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:25 INFO - Running post-action listener: _resource_record_post_action 10:11:25 INFO - ##### 10:11:25 INFO - ##### Running read-buildbot-config step. 10:11:25 INFO - ##### 10:11:25 INFO - Running pre-action listener: _resource_record_pre_action 10:11:25 INFO - Running main action method: read_buildbot_config 10:11:25 INFO - Using buildbot properties: 10:11:25 INFO - { 10:11:25 INFO - "project": "", 10:11:25 INFO - "product": "firefox", 10:11:25 INFO - "script_repo_revision": "production", 10:11:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:11:25 INFO - "repository": "", 10:11:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:11:25 INFO - "buildid": "20160623070025", 10:11:25 INFO - "pgo_build": "True", 10:11:25 INFO - "basedir": "/builds/slave/test", 10:11:25 INFO - "buildnumber": 145, 10:11:25 INFO - "slavename": "talos-linux64-ix-027", 10:11:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:11:25 INFO - "platform": "ubuntu64_hw", 10:11:25 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:11:25 INFO - "branch": "mozilla-beta", 10:11:25 INFO - "repo_path": "releases/mozilla-beta", 10:11:25 INFO - "revision": "427f987a10ab8caae5936d0b99a61d5ddd86c3d4", 10:11:25 INFO - "stage_platform": "linux64-pgo", 10:11:25 INFO - "builduid": "8b901f1499614f4a80124dd39a4d350d", 10:11:25 INFO - "slavebuilddir": "test" 10:11:25 INFO - } 10:11:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:11:25 INFO - Running post-action listener: _resource_record_post_action 10:11:25 INFO - ##### 10:11:25 INFO - ##### Running download-and-extract step. 10:11:25 INFO - ##### 10:11:25 INFO - Running pre-action listener: _resource_record_pre_action 10:11:25 INFO - Running main action method: download_and_extract 10:11:25 INFO - mkdir: /builds/slave/test/build/tests 10:11:25 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')]} 10:11:25 INFO - https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:11:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:11:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:11:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:26 INFO - Downloaded 1327 bytes. 10:11:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:11:26 INFO - Using the following test package requirements: 10:11:26 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:11:26 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:26 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:11:26 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'jsshell-linux-x86_64.zip'], 10:11:26 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:26 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:11:26 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:11:26 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:11:26 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:26 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:11:26 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11: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')]} 10:11:26 INFO - https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:27 INFO - Downloaded 24186972 bytes. 10:11:27 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'] 10:11:27 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 10:11:28 INFO - Return code: 0 10:11:28 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 10:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:28 INFO - https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:29 INFO - Downloaded 24186972 bytes. 10:11:29 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'] 10:11:29 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 10:11:31 INFO - Return code: 0 10:11:31 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')]} 10:11:31 INFO - https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:32 INFO - Downloaded 10840145 bytes. 10:11:32 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'] 10:11:32 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 10:11:32 INFO - Return code: 0 10:11: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')]} 10:11:32 INFO - https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:11:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:11:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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 10:11:33 INFO - Downloaded 55996970 bytes. 10:11:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:11:33 INFO - mkdir: /builds/slave/test/properties 10:11:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:33 INFO - Contents: 10:11:33 INFO - build_url:https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:11:34 INFO - Running post-action listener: _resource_record_post_action 10:11:34 INFO - Running post-action listener: set_extra_try_arguments 10:11:34 INFO - ##### 10:11:34 INFO - ##### Running populate-webroot step. 10:11:34 INFO - ##### 10:11:34 INFO - Running pre-action listener: _resource_record_pre_action 10:11:34 INFO - Running main action method: populate_webroot 10:11:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:34 INFO - '--tppagecycles', 10:11:34 INFO - '7'], 10:11:34 INFO - 'tests': ['tsvgm']}}, 10:11:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:11:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['damp', 'tps']}, 10:11:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'tests': ['damp', 'tps']}, 10:11:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['dromaeo_dom']}, 10:11:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['a11yr', 10:11:34 INFO - 'ts_paint', 10:11:34 INFO - 'tpaint', 10:11:34 INFO - 'sessionrestore', 10:11:34 INFO - 'sessionrestore_no_auto_restore', 10:11:34 INFO - 'tabpaint']}, 10:11:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['tsvgx', 10:11:34 INFO - 'tsvgr_opacity', 10:11:34 INFO - 'tart', 10:11:34 INFO - 'tscrollx', 10:11:34 INFO - 'cart']}, 10:11:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:34 INFO - 'tsvgr_opacity', 10:11:34 INFO - 'tart', 10:11:34 INFO - 'tscrollx', 10:11:34 INFO - 'cart']}, 10:11:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'talos_options': ['--disable-e10s'], 10:11:34 INFO - 'tests': ['tp5o']}, 10:11:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'tests': ['tp5o']}, 10:11:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'talos_options': ['--disable-e10s', 10:11:34 INFO - '--xperf_path', 10:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:34 INFO - 'tests': ['tp5n']}, 10:11:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:34 INFO - 'talos_options': ['--xperf_path', 10:11:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:34 INFO - 'tests': ['tp5n']}}, 10:11:34 INFO - 'talos.zip': {'path': '', 10:11:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:34 INFO - Running post-action listener: _resource_record_post_action 10:11:34 INFO - ##### 10:11:34 INFO - ##### Running create-virtualenv step. 10:11:34 INFO - ##### 10:11:34 INFO - Running pre-action listener: _resource_record_pre_action 10:11:34 INFO - Running main action method: create_virtualenv 10:11:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:34 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 10:11:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:34 INFO - Using real prefix '/usr' 10:11:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:34 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:36 INFO - Installing pip.................done. 10:11:36 INFO - Return code: 0 10:11:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:36 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:36 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 10:11:36 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 10:11:36 INFO - Using env: {'DISPLAY': ':0', 10:11:36 INFO - 'HOME': '/home/cltbld', 10:11:36 INFO - 'LANG': 'en_US.UTF-8', 10:11:36 INFO - 'LANGUAGE': 'en_US:en', 10:11:36 INFO - 'LOGNAME': 'cltbld', 10:11:36 INFO - 'MAIL': '/var/mail/cltbld', 10:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:36 INFO - 'MOZ_NO_REMOTE': '1', 10:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:36 INFO - 'NO_EM_RESTART': '1', 10:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:36 INFO - 'PWD': '/builds/slave/test', 10:11:36 INFO - 'SHELL': '/bin/bash', 10:11:36 INFO - 'SHLVL': '1', 10:11:36 INFO - 'TERM': 'linux', 10:11:36 INFO - 'TMOUT': '86400', 10:11:36 INFO - 'USER': 'cltbld', 10:11:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:36 INFO - '_': '/tools/buildbot/bin/python'} 10:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:37 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 10:11:37 INFO - Cleaning up... 10:11:37 INFO - Return code: 0 10:11:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:11:37 INFO - Using env: {'DISPLAY': ':0', 10:11:37 INFO - 'HOME': '/home/cltbld', 10:11:37 INFO - 'LANG': 'en_US.UTF-8', 10:11:37 INFO - 'LANGUAGE': 'en_US:en', 10:11:37 INFO - 'LOGNAME': 'cltbld', 10:11:37 INFO - 'MAIL': '/var/mail/cltbld', 10:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:37 INFO - 'MOZ_NO_REMOTE': '1', 10:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:37 INFO - 'NO_EM_RESTART': '1', 10:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:37 INFO - 'PWD': '/builds/slave/test', 10:11:37 INFO - 'SHELL': '/bin/bash', 10:11:37 INFO - 'SHLVL': '1', 10:11:37 INFO - 'TERM': 'linux', 10:11:37 INFO - 'TMOUT': '86400', 10:11:37 INFO - 'USER': 'cltbld', 10:11:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:37 INFO - '_': '/tools/buildbot/bin/python'} 10:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:37 INFO - Downloading/unpacking psutil>=0.7.1 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:39 INFO - Installing collected packages: psutil 10:11:39 INFO - Running setup.py install for psutil 10:11:39 INFO - building 'psutil._psutil_linux' extension 10:11:39 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 10:11:39 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 10:11:39 INFO - building 'psutil._psutil_posix' extension 10:11:39 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 10:11:39 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 10:11:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:39 INFO - Successfully installed psutil 10:11:39 INFO - Cleaning up... 10:11:39 INFO - Return code: 0 10:11:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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', '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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:11: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 mozsystemmonitor==0.0.0 10:11:39 INFO - Using env: {'DISPLAY': ':0', 10:11:39 INFO - 'HOME': '/home/cltbld', 10:11:39 INFO - 'LANG': 'en_US.UTF-8', 10:11:39 INFO - 'LANGUAGE': 'en_US:en', 10:11:39 INFO - 'LOGNAME': 'cltbld', 10:11:39 INFO - 'MAIL': '/var/mail/cltbld', 10:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:39 INFO - 'MOZ_NO_REMOTE': '1', 10:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:39 INFO - 'NO_EM_RESTART': '1', 10:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:39 INFO - 'PWD': '/builds/slave/test', 10:11:39 INFO - 'SHELL': '/bin/bash', 10:11:39 INFO - 'SHLVL': '1', 10:11:39 INFO - 'TERM': 'linux', 10:11:39 INFO - 'TMOUT': '86400', 10:11:39 INFO - 'USER': 'cltbld', 10:11:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:39 INFO - '_': '/tools/buildbot/bin/python'} 10:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:11:42 INFO - Installing collected packages: mozsystemmonitor 10:11:42 INFO - Running setup.py install for mozsystemmonitor 10:11:42 INFO - Successfully installed mozsystemmonitor 10:11:42 INFO - Cleaning up... 10:11:42 INFO - Return code: 0 10:11:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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', '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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:11: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 blobuploader==1.2.4 10:11:42 INFO - Using env: {'DISPLAY': ':0', 10:11:42 INFO - 'HOME': '/home/cltbld', 10:11:42 INFO - 'LANG': 'en_US.UTF-8', 10:11:42 INFO - 'LANGUAGE': 'en_US:en', 10:11:42 INFO - 'LOGNAME': 'cltbld', 10:11:42 INFO - 'MAIL': '/var/mail/cltbld', 10:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:42 INFO - 'MOZ_NO_REMOTE': '1', 10:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:42 INFO - 'NO_EM_RESTART': '1', 10:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:42 INFO - 'PWD': '/builds/slave/test', 10:11:42 INFO - 'SHELL': '/bin/bash', 10:11:42 INFO - 'SHLVL': '1', 10:11:42 INFO - 'TERM': 'linux', 10:11:42 INFO - 'TMOUT': '86400', 10:11:42 INFO - 'USER': 'cltbld', 10:11:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:42 INFO - '_': '/tools/buildbot/bin/python'} 10:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:44 INFO - Downloading docopt-0.6.1.tar.gz 10:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:45 INFO - Running setup.py install for blobuploader 10:11:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:45 INFO - Running setup.py install for requests 10:11:45 INFO - Running setup.py install for docopt 10:11:45 INFO - Successfully installed blobuploader requests docopt 10:11:45 INFO - Cleaning up... 10:11:45 INFO - Return code: 0 10:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:45 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 10:11:45 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 10:11:45 INFO - Using env: {'DISPLAY': ':0', 10:11:45 INFO - 'HOME': '/home/cltbld', 10:11:45 INFO - 'LANG': 'en_US.UTF-8', 10:11:45 INFO - 'LANGUAGE': 'en_US:en', 10:11:45 INFO - 'LOGNAME': 'cltbld', 10:11:45 INFO - 'MAIL': '/var/mail/cltbld', 10:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:45 INFO - 'MOZ_NO_REMOTE': '1', 10:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:45 INFO - 'NO_EM_RESTART': '1', 10:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:45 INFO - 'PWD': '/builds/slave/test', 10:11:45 INFO - 'SHELL': '/bin/bash', 10:11:45 INFO - 'SHLVL': '1', 10:11:45 INFO - 'TERM': 'linux', 10:11:45 INFO - 'TMOUT': '86400', 10:11:45 INFO - 'USER': 'cltbld', 10:11:45 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:45 INFO - '_': '/tools/buildbot/bin/python'} 10:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:45 INFO - Running setup.py (path:/tmp/pip-bLxYsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:45 INFO - Running setup.py (path:/tmp/pip-byXY9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:46 INFO - Running setup.py (path:/tmp/pip-lpiOIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:46 INFO - Running setup.py (path:/tmp/pip-GPGVu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:46 INFO - Running setup.py (path:/tmp/pip-sH2l3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:46 INFO - Running setup.py (path:/tmp/pip-vYXgZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:46 INFO - Running setup.py (path:/tmp/pip-F2a40D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:46 INFO - Running setup.py (path:/tmp/pip-fYQt_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:46 INFO - Running setup.py (path:/tmp/pip-8diIGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:46 INFO - Running setup.py (path:/tmp/pip-_aUgxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:46 INFO - Running setup.py (path:/tmp/pip-rHqDoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:46 INFO - Running setup.py (path:/tmp/pip-OiplRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:46 INFO - Running setup.py (path:/tmp/pip-Il9KTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:46 INFO - Running setup.py (path:/tmp/pip-cyBlXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:46 INFO - Running setup.py (path:/tmp/pip-4cG2s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:46 INFO - Running setup.py (path:/tmp/pip-rYeCZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:47 INFO - Running setup.py (path:/tmp/pip-zma0b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:47 INFO - Running setup.py install for manifestparser 10:11:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Running setup.py install for mozcrash 10:11:47 INFO - Running setup.py install for mozdebug 10:11:47 INFO - Running setup.py install for mozdevice 10:11:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Running setup.py install for mozfile 10:11:47 INFO - Running setup.py install for mozhttpd 10:11:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Running setup.py install for mozinfo 10:11:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Running setup.py install for mozInstall 10:11:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:47 INFO - Running setup.py install for mozleak 10:11:48 INFO - Running setup.py install for mozlog 10:11:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Running setup.py install for moznetwork 10:11:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Running setup.py install for mozprocess 10:11:48 INFO - Running setup.py install for mozprofile 10:11:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Running setup.py install for mozrunner 10:11:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Running setup.py install for mozscreenshot 10:11:48 INFO - Running setup.py install for moztest 10:11:48 INFO - Running setup.py install for mozversion 10:11:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:48 INFO - Cleaning up... 10:11:48 INFO - Return code: 0 10:11:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:48 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:48 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 10:11:48 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 10:11:48 INFO - Using env: {'DISPLAY': ':0', 10:11:48 INFO - 'HOME': '/home/cltbld', 10:11:48 INFO - 'LANG': 'en_US.UTF-8', 10:11:48 INFO - 'LANGUAGE': 'en_US:en', 10:11:48 INFO - 'LOGNAME': 'cltbld', 10:11:48 INFO - 'MAIL': '/var/mail/cltbld', 10:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:48 INFO - 'MOZ_NO_REMOTE': '1', 10:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:48 INFO - 'NO_EM_RESTART': '1', 10:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:48 INFO - 'PWD': '/builds/slave/test', 10:11:48 INFO - 'SHELL': '/bin/bash', 10:11:48 INFO - 'SHLVL': '1', 10:11:48 INFO - 'TERM': 'linux', 10:11:48 INFO - 'TMOUT': '86400', 10:11:48 INFO - 'USER': 'cltbld', 10:11:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:48 INFO - '_': '/tools/buildbot/bin/python'} 10:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:49 INFO - Running setup.py (path:/tmp/pip-NqgApW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:49 INFO - Running setup.py (path:/tmp/pip-IX5cPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:49 INFO - Running setup.py (path:/tmp/pip-TNNQru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:49 INFO - Running setup.py (path:/tmp/pip-pBr2_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:49 INFO - Running setup.py (path:/tmp/pip-HzMQ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:49 INFO - Running setup.py (path:/tmp/pip-gGXfK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:49 INFO - Running setup.py (path:/tmp/pip-0wkTmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:49 INFO - Running setup.py (path:/tmp/pip-Wm9feq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:49 INFO - Running setup.py (path:/tmp/pip-HsRqkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:49 INFO - Running setup.py (path:/tmp/pip-FAvP5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:49 INFO - Running setup.py (path:/tmp/pip-r1SqI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:49 INFO - Running setup.py (path:/tmp/pip-M5fPKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:49 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)) 10:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:49 INFO - Running setup.py (path:/tmp/pip-eVAfRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:50 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)) 10:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:50 INFO - Running setup.py (path:/tmp/pip-rC4FHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:50 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)) 10:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:50 INFO - Running setup.py (path:/tmp/pip-gS7Z6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:50 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)) 10:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:50 INFO - Running setup.py (path:/tmp/pip-t6r3gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:50 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)) 10:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:50 INFO - Running setup.py (path:/tmp/pip-NX7i1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:50 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)) 10:11:50 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)) 10:11:50 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)) 10:11:50 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)) 10:11:50 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)) 10:11:50 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)) 10:11:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:52 INFO - Downloading blessings-1.6.tar.gz 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:52 INFO - Installing collected packages: blessings 10:11:52 INFO - Running setup.py install for blessings 10:11:52 INFO - Successfully installed blessings 10:11:52 INFO - Cleaning up... 10:11:52 INFO - Return code: 0 10:11:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:52 INFO - Reading from file tmpfile_stdout 10:11:52 INFO - Current package versions: 10:11:52 INFO - argparse == 1.2.1 10:11:52 INFO - blessings == 1.6 10:11:52 INFO - blobuploader == 1.2.4 10:11:52 INFO - docopt == 0.6.1 10:11:52 INFO - manifestparser == 1.1 10:11:52 INFO - mozInstall == 1.12 10:11:52 INFO - mozcrash == 0.17 10:11:52 INFO - mozdebug == 0.1 10:11:52 INFO - mozdevice == 0.48 10:11:52 INFO - mozfile == 1.2 10:11:52 INFO - mozhttpd == 0.7 10:11:52 INFO - mozinfo == 0.9 10:11:52 INFO - mozleak == 0.1 10:11:52 INFO - mozlog == 3.1 10:11:52 INFO - moznetwork == 0.27 10:11:52 INFO - mozprocess == 0.22 10:11:52 INFO - mozprofile == 0.28 10:11:52 INFO - mozrunner == 6.11 10:11:52 INFO - mozscreenshot == 0.1 10:11:52 INFO - mozsystemmonitor == 0.0 10:11:52 INFO - moztest == 0.7 10:11:52 INFO - mozversion == 1.4 10:11:52 INFO - psutil == 3.1.1 10:11:52 INFO - requests == 1.2.3 10:11:52 INFO - wsgiref == 0.1.2 10:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:52 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:52 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 10:11:52 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 10:11:52 INFO - Using env: {'DISPLAY': ':0', 10:11:52 INFO - 'HOME': '/home/cltbld', 10:11:52 INFO - 'LANG': 'en_US.UTF-8', 10:11:52 INFO - 'LANGUAGE': 'en_US:en', 10:11:52 INFO - 'LOGNAME': 'cltbld', 10:11:52 INFO - 'MAIL': '/var/mail/cltbld', 10:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:52 INFO - 'MOZ_NO_REMOTE': '1', 10:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:52 INFO - 'NO_EM_RESTART': '1', 10:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:52 INFO - 'PWD': '/builds/slave/test', 10:11:52 INFO - 'SHELL': '/bin/bash', 10:11:52 INFO - 'SHLVL': '1', 10:11:52 INFO - 'TERM': 'linux', 10:11:52 INFO - 'TMOUT': '86400', 10:11:52 INFO - 'USER': 'cltbld', 10:11:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:52 INFO - '_': '/tools/buildbot/bin/python'} 10:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 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)) 10:11:52 INFO - Cleaning up... 10:11:52 INFO - Return code: 0 10:11:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:52 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:52 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 10:11:52 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 10:11:52 INFO - Using env: {'DISPLAY': ':0', 10:11:52 INFO - 'HOME': '/home/cltbld', 10:11:52 INFO - 'LANG': 'en_US.UTF-8', 10:11:52 INFO - 'LANGUAGE': 'en_US:en', 10:11:52 INFO - 'LOGNAME': 'cltbld', 10:11:52 INFO - 'MAIL': '/var/mail/cltbld', 10:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:52 INFO - 'MOZ_NO_REMOTE': '1', 10:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:52 INFO - 'NO_EM_RESTART': '1', 10:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:52 INFO - 'PWD': '/builds/slave/test', 10:11:52 INFO - 'SHELL': '/bin/bash', 10:11:52 INFO - 'SHLVL': '1', 10:11:52 INFO - 'TERM': 'linux', 10:11:52 INFO - 'TMOUT': '86400', 10:11:52 INFO - 'USER': 'cltbld', 10:11:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:52 INFO - '_': '/tools/buildbot/bin/python'} 10:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:53 INFO - Downloading/unpacking jsonschema 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:55 INFO - Downloading/unpacking functools32 (from jsonschema) 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:55 INFO - warning: no files found matching '*.txt' 10:11:55 INFO - no previously-included directories found matching 'build' 10:11:55 INFO - no previously-included directories found matching 'dist' 10:11:55 INFO - no previously-included directories found matching '.git*' 10:11:55 INFO - Installing collected packages: jsonschema, functools32 10:11:55 INFO - Running setup.py install for functools32 10:11:55 INFO - warning: no files found matching '*.txt' 10:11:55 INFO - no previously-included directories found matching 'build' 10:11:55 INFO - no previously-included directories found matching 'dist' 10:11:55 INFO - no previously-included directories found matching '.git*' 10:11:55 INFO - Successfully installed jsonschema functools32 10:11:55 INFO - Cleaning up... 10:11:55 INFO - Return code: 0 10:11:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:55 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 0x7f381166ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, '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': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', '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 10:11:55 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 10:11:55 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 10:11:55 INFO - Using env: {'DISPLAY': ':0', 10:11:55 INFO - 'HOME': '/home/cltbld', 10:11:55 INFO - 'LANG': 'en_US.UTF-8', 10:11:55 INFO - 'LANGUAGE': 'en_US:en', 10:11:55 INFO - 'LOGNAME': 'cltbld', 10:11:55 INFO - 'MAIL': '/var/mail/cltbld', 10:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:55 INFO - 'MOZ_NO_REMOTE': '1', 10:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:55 INFO - 'NO_EM_RESTART': '1', 10:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:55 INFO - 'PWD': '/builds/slave/test', 10:11:55 INFO - 'SHELL': '/bin/bash', 10:11:55 INFO - 'SHLVL': '1', 10:11:55 INFO - 'TERM': 'linux', 10:11:55 INFO - 'TMOUT': '86400', 10:11:55 INFO - 'USER': 'cltbld', 10:11:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:55 INFO - '_': '/tools/buildbot/bin/python'} 10:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:55 INFO - Downloading/unpacking flake8 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:11:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:11:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:58 INFO - no previously-included directories found matching 'docs/_build' 10:11:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:11:58 INFO - Running setup.py install for pep8 10:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:58 INFO - no previously-included directories found matching 'docs/_build' 10:11:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:11:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:11:58 INFO - Cleaning up... 10:11:58 INFO - Return code: 0 10:11:58 INFO - Running post-action listener: _resource_record_post_action 10:11:58 INFO - Running post-action listener: _start_resource_monitoring 10:11:58 INFO - Starting resource monitoring. 10:11:58 INFO - ##### 10:11:58 INFO - ##### Running install step. 10:11:58 INFO - ##### 10:11:58 INFO - Running pre-action listener: _resource_record_pre_action 10:11:58 INFO - Running main action method: install 10:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:58 INFO - Reading from file tmpfile_stdout 10:11:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:11:58 INFO - Reading from file tmpfile_stdout 10:11:58 INFO - Output received: 10:11:58 INFO - Usage: mozinstall [options] installer 10:11:58 INFO - Options: 10:11:58 INFO - -h, --help show this help message and exit 10:11:58 INFO - -d DEST, --destination=DEST 10:11:58 INFO - Directory to install application into. [default: 10:11:58 INFO - "/builds/slave/test"] 10:11:58 INFO - --app=APP Application being installed. [default: firefox] 10:11:58 INFO - mkdir: /builds/slave/test/build/application 10:11:58 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'] 10:11:58 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 10:12:12 INFO - Reading from file tmpfile_stdout 10:12:12 INFO - Output received: 10:12:12 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:12 INFO - Running post-action listener: _resource_record_post_action 10:12:12 INFO - ##### 10:12:12 INFO - ##### Running run-tests step. 10:12:12 INFO - ##### 10:12:12 INFO - Running pre-action listener: _resource_record_pre_action 10:12:12 INFO - Running main action method: run_tests 10:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:12 INFO - Python 2.7.3 10:12:12 INFO - Return code: 0 10:12:12 INFO - grabbing minidump binary from tooltool 10:12:12 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')]} 10:12:12 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 0x13c9410>, '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 0x13ca310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ca7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:12 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 10:12:12 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 10:12:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:12 INFO - Return code: 0 10:12:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:13 INFO - Return code: 0 10:12:13 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/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:12:13 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/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 10:12:13 INFO - Using env: {'DISPLAY': ':0', 10:12:13 INFO - 'HOME': '/home/cltbld', 10:12:13 INFO - 'LANG': 'en_US.UTF-8', 10:12:13 INFO - 'LANGUAGE': 'en_US:en', 10:12:13 INFO - 'LOGNAME': 'cltbld', 10:12:13 INFO - 'MAIL': '/var/mail/cltbld', 10:12:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:13 INFO - 'MOZ_NO_REMOTE': '1', 10:12:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:13 INFO - 'NO_EM_RESTART': '1', 10:12:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:13 INFO - 'PWD': '/builds/slave/test', 10:12:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:13 INFO - 'SHELL': '/bin/bash', 10:12:13 INFO - 'SHLVL': '1', 10:12:13 INFO - 'TERM': 'linux', 10:12:13 INFO - 'TMOUT': '86400', 10:12:13 INFO - 'USER': 'cltbld', 10:12:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165', 10:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:13 INFO - '_': '/tools/buildbot/bin/python'} 10:12:13 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/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 10:12:13 INFO - mozversion application_buildid: 20160623070025 10:12:13 INFO - mozversion application_changeset: 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 10:12:13 INFO - mozversion application_display_name: Firefox 10:12:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:13 INFO - mozversion application_name: Firefox 10:12:13 INFO - mozversion application_remotingname: firefox 10:12:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:12:13 INFO - mozversion application_vendor: Mozilla 10:12:13 INFO - mozversion application_version: 48.0 10:12:13 INFO - mozversion platform_buildid: 20160623070025 10:12:13 INFO - mozversion platform_changeset: 427f987a10ab8caae5936d0b99a61d5ddd86c3d4 10:12:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:12:13 INFO - mozversion platform_version: 48.0 10:12:13 INFO - using testdate: 1466701933 10:12:13 INFO - actual date: 1466701933 10:12:13 INFO - starting webserver on 'localhost:56829' 10:12:13 INFO - SUITE-START | Running 2 tests 10:12:13 INFO - TEST-START | dromaeo_css 10:12:13 INFO - operating with platform_type : linux_ 10:12:13 INFO - Initialising browser for dromaeo_css test... 10:12:13 INFO - TEST-INFO | started process 26074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNk9Y3_/profile http://localhost:56829/getInfo.html) 10:12:16 INFO - PROCESS | 26074 | 10:12:16 INFO - PROCESS | 26074 | (process:26154): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:17 INFO - PROCESS | 26074 | __metrics Screen width/height:1600/1200 10:12:17 INFO - PROCESS | 26074 | colorDepth:24 10:12:17 INFO - PROCESS | 26074 | Browser inner width/height: 1024/697 10:12:17 INFO - PROCESS | 26074 | __metrics 10:12:17 ERROR - PROCESS | 26074 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:12:18 INFO - TEST-INFO | 26074: exit 0 10:12:18 INFO - Browser initialized. 10:12:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:18 INFO - TEST-INFO | started process 26204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNk9Y3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:20 INFO - PROCESS | 26204 | 10:12:20 INFO - PROCESS | 26204 | (process:26271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:30 INFO - PROCESS | 26204 | RSS: Main: 150581248 10:12:30 INFO - PROCESS | 26204 | 10:13:20 INFO - PROCESS | 26204 | 1466702000062 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] 10:15:27 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56829/tests/dromaeo/cssquery-ext.html) 10:15:28 INFO - PROCESS | 26204 | RSS: Main: 154693632 10:15:28 INFO - PROCESS | 26204 | 10:18:30 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-ext.html (next: http://localhost:56829/tests/dromaeo/cssquery-jquery.html) 10:18:31 INFO - PROCESS | 26204 | RSS: Main: 152420352 10:18:31 INFO - PROCESS | 26204 | 10:21:32 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56829/tests/dromaeo/cssquery-mootools.html) 10:21:33 INFO - PROCESS | 26204 | RSS: Main: 152510464 10:21:33 INFO - PROCESS | 26204 | 10:24:34 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56829/tests/dromaeo/cssquery-prototype.html) 10:24:35 INFO - PROCESS | 26204 | RSS: Main: 153554944 10:24:35 INFO - PROCESS | 26204 | 10:27:37 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56829/tests/dromaeo/cssquery-yui.html) 10:27:38 INFO - PROCESS | 26204 | RSS: Main: 151760896 10:27:38 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | Cycle 1(1): loaded http://localhost:56829/tests/dromaeo/cssquery-yui.html (next: http://localhost:56829/tests/dromaeo/cssquery-dojo.html) 10:30:40 INFO - PROCESS | 26204 | RSS: Main: 155566080 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | __start_tp_report 10:30:40 INFO - PROCESS | 26204 | _x_x_mozilla_page_load 10:30:40 INFO - PROCESS | 26204 | _x_x_mozilla_page_load_details 10:30:40 INFO - PROCESS | 26204 | |i|pagename|runs| 10:30:40 INFO - PROCESS | 26204 | |0;dojo.html;3357.748168887333;3398.3373242217776;3408.3012982338614;3425.2122011937267;3426.246225830318;5625.32496100468;5626.409227031159;5640.210370548127;5659.66042037478;5664.575156863231;5611.80358687446;5622.240997465341;5643.717814109299;5656.858578535539;5676.205331253617;5059.873503162423;5126.948730512703;5128.615353848458;5135.204043373283;5170.353705786777;5124.154514505102;5191.636585439021;5287.4976877196605;5297.390800057985;5300.151975683892;5255.684658920458;5282.3925248596515;5318.867028324304;5326.041312563737;5344.038073146832;5281.603879709018;5307.442718514559;5312.893742125175;5317.12267475866;5325.547328477084;5035.093683137071;5130.71781052042;5203.453637368098;5218.452062533417;5275.815346462856;5490.231367608538;5492.835214943558;5510.724463776795;5528.281323427969;5549.556035517149;5986.97006514969;6020.096985452174;6039.969800151015;6044.455998960071;6054.8183554493435;6086.6956652167655;6106.72519736613;6114.785982490592;6120.510359171256;6130.917941863022;5793.13103034544;5796.478316951495;5805.10020946754;5814.156947242668;5829.737661805187;6332.68336583169;6335.208098987627;6337.366263373626;6340.873182536324;6344.397282258178;5850.180974663551;5883.3234178069215;5950.107483877367;5985.880282394328;6071.51427885768;6031.819045428644;6047.758089676364;6057.97014507526;6064.211652485237;6076.270847498328;5982.611130276518;6017.608855424383;6043.153958445821;6044.667543285073;6050.727717252734;5987.64074155552;6046.697665116727;6108.847278818065;6118.4668989547035;6132.78385080153;4573.153966516205;4595.747233902101;4613.607843333354;4618.97690511552;4638.1883170445035;4131;4136.276151673445;4145.461090058273;4161.167766446722;4163.417121602917;5799.420057994251;5805;5914.615549989237;5975.282966044103;6013.6993150342305;6219.626822390671;6239.563230573816;6249.25008998923;6252.218472690914;6266.122742816009;5771.595988280864;5956.225690660186;5971.940280597139;5994.381516990476;6024.277086749618;5233.1365324721755;5247.921281180786;5269.841904742864;5302.628815982921;5312.150055991023;6326.304106548276;6341.302456729756;6351.872962540723;6361.077643741632;6362.9045564316575;6128.233970753656;6131.908021379593;6134.9079763804475;6136.140940268366;6137.407629318989;6379.234491861006;6433.260175079926;6446.967765161145;6498.74005039812;6499.025146228104;6022.066579680157;6059.33347331802;6070.2412198475195;6073.119397687399;6091.329953705177;5865.618734782225;6170.475509581556;6178.1350610913605;6195.318514963441;6213.689315534115;5991.310999235144;6000.489958353589;6005.969970150121;6050.062240352752;6086.239220097488;6039.63762174271;6040.516758659384;6043.486303664238;6049.818505444844;6053.182820319201;5768.394318596487;5912.260967379078;5963.701814909324;5978.641281523122;6043.697815109315;6045.183900173421;6098.817035488943;6107.816765497042;6117.1130186123655;6137.232845894263;5926.288845338587;5972.940270597239;5974.850628734316;5979.013462778767;6004.939950600613 10:30:40 INFO - PROCESS | 26204 | |1;ext.html;607.7963882099497;642.7461152844627;661.2692974263439;672.0792514255473;678.2098854834119;40539.59460405395;40542;40613.39079913804;40797;40807.591924080785;44591.77704111483;45173.09653806922;45209.321860172124;45253;45404;8882;9067.909320906805;9070.138336857988;9087.545622718872;9090.863637045417;8803.911960880374;8804.207621314112;8836.955815220916;8899.37704360695;8925.285977121815;9196.172344488994;9251.491167985758;9267.073292670713;9280.35037547372;9301.627934882597;9100.180983711465;9216.631334746602;9222.815543689123;9223.631054757769;9234.769130771718;9014.459132452008;9153.81692366149;9161.496117713523;9193.586288617029;9197;45541.772291138666;46024.76987615074;46088.53911460876;46105;46231.30653040207;3837.76973381598;3959.4060890866313;4035.7578545287083;4079;4347.108842687241;32860.50709239364;33142.834285828416;33261.16847078818;33349.83325083359;33784.6621533784;4535.863924082283;4640.744759038252;4651.348811166439;4667.369905062807;4685.882852928704;291933;292033.5398323016;294023;295133;296154;67999.66000169968;68191.3180868185;68395.31604683989;68459;68950.3104968954;73549.63225183947;74057;74163;74359.62820185865;74578.25421745822;18446.35437759672;18825.717614235797;18872.622547549247;18881.433556993314;18992;13785.172889626454;13926.791098133535;14004.509842155476;14040.1575905446;14061.859381406055;20723.58552828935;21237.893810530848;21247.150113995267;21257.89371053135;21847.672284915738;7493.4005279577505;7509.474336796481;7604.528528228348;7657.157712651604;7849.058113026474;1059.2108878885126;1115.0912006714502;1125.8648962124598;1178.8290697848763;1190.8746234808023;33939.66060339414;34476.48285275723;34804.825975870466;34822.47766283508;34987.61773101133;1166.988330116688;1214.2410993129295;1221.877812218771;1246.2522486508024;1281.3529167770216;17543.912280438515;17751;17888;17989.7301540477;18068.819311806714;522938;550132;551016;579075;592387;60133;60862.087068694;61141.694291529144;61379.6931015351;61474.38525614776;1515.2348064227715;1522.0335087219473;1522.0715363628178;1523.5200911712775;1529.0596283285922;34827.30345393129;34953.126171845906;35468;35602;35756.46365304574;58330.708346458;58382.708086460996;59028;59047.40952590419;59125;470994;478569;479345;479931;481030;32557.83721081474;32859.34281314408;33158.83420582882;33231;33483.330333393686;53826.19260711014;54173;54253;54524.72737636286;55231;43784.56215437805;44956.325655115856;45882;45960.31059534177;46634.76682616701;43830;44723;44743.72241135401;46119.76940115278;46132.769336153106;40452;40942.1811563773;41004.794976026125;41413.171736564494;41623.7918810404;33840.3231935355;34472.79345222905;34607.480887787206;35076.82461587676;35140.82429587836;27470.45059098847;28072;29529.409411811215;30068.849655751583;30257 10:30:40 INFO - PROCESS | 26204 | |2;jquery.html;436.42392042503906;444.1538868455591;446.5445245849234;448.7860337786288;455.19885002395796;19139.808601913977;19391.515212119688;19735.703964440527;21436.785632143674;21462.463438414048;20053;20397.59204815903;20605;20612.793872061276;20654.173833046698;5817.214676018736;6054.666993315366;6100.603460775058;6106.358832322609;6106.786262480814;5651.5761317901115;5912.260967379078;5980.820575382745;5999.970000149993;6010.609310394832;5506.284183056197;5951.345352011275;5953.553483488734;5980.684249465133;6017.097435384705;5826.067829147359;5834.474897259267;5839.591228613998;5850.707464626752;5860.003799354099;5644.943550564483;5815.098659707752;5943.4056594340655;5947.5539334550085;5965.850853728648;14883.851161488356;15184.544463665998;15205.467808626645;23120.0751969921;23297;2350.788429041377;2383.3088404362716;2385.415573184581;2412.143688990418;2468.1978357034036;10586.41774702391;10716.196285278635;12333.876661233453;14662.046966947115;14785.334659940328;1983.8710483818506;2043.090824583061;2117;2127.191667166482;2229.598672238996;69951.300486995;84841.57579212064;85300.57349713212;85757.57121214416;89113.55443222808;11465.312081274984;11534.826977595343;11686.88313116875;11800.763984720257;12050.337231452355;16396;16610.25253863555;16642.916785416237;16708.331666733437;16855.915720421566;8796.252318552866;9109;9149.542522873962;9267.67563135287;9298.257014180834;9044.186023257938;9044.547772611342;9057.09429057089;9122.179003889682;9133.72598822023;5106.540411362995;5133.820316288912;5171.68969861802;5184.403793563789;5292.417834038252;1941.2041063164318;2056.8868712220674;2148;2165.5019345550613;2218.1460137847043;1021.4075836015094;1059.3749687684149;1083.6803143072655;1146.7649131928101;1185.6917201527665;19000.61998760017;19639.31262405809;19747.308844190673;19917;20298.89850550738;1062.3094988257694;1073.7423018475665;1098.6649072033106;1130.9151813614012;1133.863936327646;10871.29336593119;11388.259763115371;11507.194496385173;11528.827067593993;11686.357250351311;525530.5009967963;539510;540571;541878;560840;96081.51959240298;96749;98127.50936245416;98153;99547.50226248823;1097.7255686078481;1113.732704151014;1123.4158237716342;1134.744682446443;1137.3687603380038;17257.79195456306;17701.20344584471;17834.732479013084;17895.642087157925;18216.180271887533;36691.81654091713;37096;37792.811035944644;37855.81072094622;40908.795456022526;53394.1990870145;55764.72117639386;56468.43531564796;56490.71754641201;56874.43125568691;8665.43674661145;8784.121587841164;8789.648414063366;9008.189262966365;9194;9292.236644159126;13597.592072237849;14196.722294993087;14239.216843073731;14240.430382784572;11835.940820295844;12529;12751.234925904475;12944.288064156184;13039.478420863059;12466.189697669623;12528.498860045496;12531.498740050296;12618.55835045769;12956.963442924354;11298.265612735146;11471.197016208785;11773.234739741889;11975.461104250504;12983.610491685264;8938.821223575362;9318.114779095975;9392.530373481435;9692.127708506268;9697.709068727949;9051.31000562525;12631.431585578855;12655.240685558896;12705.42825572833;12862.228266304051 10:30:40 INFO - PROCESS | 26204 | |3;mootools.html;1575.204521716533;1577.8816588755842;1758.8241175882413;1906.8379187769049;1919.9424017279487;7423.29478699524;8170.223828736261;8363.289120424764;8522.87215691765;8549.786255343619;8107.108218096005;8135.4305198635975;8179.91820081799;8210.712625058124;8224.177582241773;2397.868117253555;2417.782399584037;2423.7697418745192;2431.0761910473993;2434.7565243475688;2368.3842201027683;2372.4424760181346;2426.3206302235403;2441.2554170977846;2444.816638752092;2409.8192635552405;2410.8312418130736;2437.81716371272;2448.3267101547126;2463.4087818923417;2368.9644655330185;2390.187336305647;2417.492326611414;2428.453597940458;2432.9878350608224;2368.396059004943;2379.48840999186;2379.8691071991034;2385.4632707640817;2393.4255778613183;8389.496630202208;8425.241728244426;8439.83120337596;8445.155484451567;8476.110008449148;5409.56723462122;5518.310211223597;5559.555235581144;5559.999200143972;5567.2762540869835;3535.1338921964284;3600.819959002066;3615.927681446383;3735.1035751419736;3772.0758414188426;1109.290054365207;1174.3130268792765;1178.6169494914186;1191.2197510630465;1199.91023115478;12205.755884882252;12255;12268.99999999991;12294.631161065183;12349.567765128268;4932.778024988884;4956.776945037482;4980.302757613937;5002.924956125661;5013.097642424325;10364.481775911174;10406.947965260277;10429.165666746641;10434.321769085136;10453.529591168415;5480.780768769205;5515.420880807457;5533.418991005887;5535.252740880011;5540.030494663418;4292.978535107367;4890.364252647204;4973.55238028572;4992.775325110379;5018.172001619765;4172.7913604319665;4178.185253875526;4221.78891055446;4261.169072030986;4277.567015049931;1396.6298930783148;1398.0772690024535;1406.7116241170536;1413.0885578801615;1418.5106138382241;964.4358050540512;1041.520900385831;1068.3643232276784;1074.3929679730927;1082.3397727386289;5865.794697185578;6045.576809623372;6070.2108725865355;6146.6004709693725;6198.907016394758;487.81219230595764;493.75065591875875;495.6679025053223;496.7565892712545;512.8487096306599;3662.8351724172476;3691.53855768029;3995.580464051291;4154.619767401223;4202.432671589358;10737.194710396752;10943.398113103856;10958.397288149228;10976.890231097746;10992.28550144238;10569.894301056891;10791.6222932197;10794.73013174677;10799.406032668121;10801.783964320826;8274.172582741678;8445.282151017109;8448.78878028042;8458.746237613004;8469.32245420365;5915.171875937286;6015;6051;6161.568690191643;6179.16581261524;9465.290103242147;9514.809703806024;9770.951145244228;9795.16741076988;9802.26483013791;9564.282678798978;9845.704628861145;9867.654632087842;10018.248631352531;10033.949830250802;6782.864342713019;7753;7833.569153696373;7834;7855.882161767464;8323.500589964622;8350.58247087631;8353.582320884054;8372.790680233044;8389.496630202208;7557.622118894144;7700.691972321044;7727.729529466442;7747.45050989793;7844.4901081429525;7615.885761713468;7617.200193979553;7705.383569314329;7713.112992005991;7791.727289544839;6830.282820303796;6832.316768323128;6843.931560684329;6850.828729281808;6886.48351373639;5177.715225662625;5206.791728330824;5270.472952704698;5288.9471105289995;5330.9733451332495;5306.54894333986;5343.198520221998;5409.107497263065;5474.835754927359;5518.255035570147 10:30:40 INFO - PROCESS | 26204 | |4;prototype.html;358.84210947183254;360.9873654422096;365.4043908429263;370.7219585311017;373.57599124993135;6397.904031439521;6444.838879028027;6520.44576211022;6657.533972621913;6666.966665166673;6540.542162048659;6567.507436942225;6587.3412658734105;6593.53845230834;6600.405963463288;4993.6005119590345;4997.850064498062;4998.6750861193905;4999.550040496355;5011.423686276088;4966.056449274644;4969.950300496985;5002.424721157059;5004.274380214885;5006.299118123466;4939.937913348629;4957.206846904496;4968.87577810554;4971.925421118686;4977.925331120036;4734.455537613184;4871;4958.206686930092;4961.032598643266;4978.153713868633;4233.1322078973735;4244.469441319835;4247.787610619487;4254.000309927164;4254.744715317091;6240.656763877985;6246.281677607042;6254.655993920333;6263.185785847811;6270.122182894398;5707.6575405475805;5763.1355296705415;5764.106563482625;5774.855628609276;5780.335261444903;6940.6529673516125;6942.757003504904;6943.097397338364;6943.9652801735665;6964.651767411609;4634.467036290836;4757.690750101232;4773.618110551148;4790.329353890458;4795.832145874912;7155.67799449026;7158.570485770871;7191.137063552354;7233.095863017175;7265.927340726578;4898.681585696918;4907.411110666742;4907.901841963141;4910.091633047898;4921.434035085939;4960.801567937242;4965.652404331662;4966.826161084345;4969.403671559436;4970.52779985908;5754.510866576305;5757.481826635623;5763.682997435098;5772.220750198753;5778;6884.65576721172;6985.231624521299;6997.755078572225;7005.404540614105;7007.824804379829;1695.3557648093645;1704.4971733338696;1714.9228284727217;1718.8109307976113;1721.5610019444962;1029.1766586730585;1137.4312843578211;1143.17691262291;1153.4463457540428;1165.4988355007429;6696.59820410777;6867.381935625718;6868.484863635247;6869.7595584154315;6890.1731792184255;7261.3827824634445;7263.7457688981685;7264.927350726425;7273.745418910313;7273.745418910418;6867.759628413081;6873.2783057778215;6876.518643694893;6880;6884.105066341343;3838.213166300902;3889.3193691103943;3927.7839718815167;3931;3934.9606503935165;7639.732609358646;7641.426892982938;7643;7650.349720273728;7666.156722760492;7362.705491780269;7391.852162956819;7395.297446742551;7404.518706284182;7420.666070026862;7602.961985190039;7613.771586852404;7622.923770762332;7632.503887247422;7633.809154771064;7047.224805271314;7231.16841563227;7232.276772322725;7238.312360325761;7240.96379518099;7059.964700176466;7112.715491380287;7123.608201548965;7138.964305178441;7141.750038748619;7544.698212071456;7554.3201111898;7565.356944659766;7607.429442791702;7608.125065617525;4751.904961900812;4779.784909679142;4788.521147885183;4793.640476964172;4796;7096.467764917755;7209.35115839577;7221.205667376479;7222.422206223595;7238.0952380952385;6976.965115174392;6995.195552511323;6998.195207551197;7002.894956575554;7012.053372794608;6927.3419025192525;6959.130108736408;6976.6860491277;6980.616066116412;6985.057017302599;6810.5913645181445;6829.317068293131;6834.658267086726;6844.315568443315;6847.760328388483;6867.244603093556;7009.754658586925;7048.436125110082;7057.153141623038;7082.610456424946;6680.766173183915;6881.10545629065;6943.756968506078;6965.164180298397;6983.790486285419 10:30:40 INFO - PROCESS | 26204 | |5;yui.html;930.6324002019203;937.5031233446274;957.8323793336165;958.2908647600773;961.6922584772875;14943.850561494382;15126.319315630795;15140.167290799001;15147;15190.392384304629;12822.422990965406;14209.147451152938;14264.572062838106;14406.639834004156;14431.350589223484;885.4465958775766;904.8235594059161;909.781652403425;911.079809392515;911.0980129671643;882.1046637662778;883.9646414143426;889.8042430665244;891.9643214271422;894.8299823033635;934.9158575728183;935.7847695030147;937.4328531238571;941.0589410589411;942.2885721280423;925.2181906289209;925.3938670171049;925.5187302602643;926.8517037274038;927.9257659387233;686.3994005245411;687.5530904911798;687.6252442418894;688.0607970120799;690.1890278922247;13597.524086657018;13617.863821361758;13629.454821807116;13653.522126725517;13722.176669399769;12890.742185156338;13084.869151308556;13095.017873659513;13159.210447373189;13164.802527962089;10893.346399216072;10893.727656808564;10909.454527273605;11012.063974562172;11107.83338249927;3993.560708322082;4043.716939814214;4072.75563466193;4110.219058378899;4123.711340206187;46010.53989460096;49141.75429122867;53925;54766.178507322424;65257.67371163114;12404.937975310066;12499.437525311201;12556.246625202517;12690.555830545887;12799.936000319938;21908.890455547622;21913.233036843634;21914.12343506274;21937.451563711034;21950.560988780137;9052.411593246417;9323.813523729488;9328.906710932939;9401.435913845191;9666.613335466644;5016.2224855147515;5071.087204303187;5124.128898087334;5154.5360917516855;5220.295260139833;3576.0523461282783;3622.221222437136;3633.2006958469096;3634.6547078028075;3638.599754027055;686.3479694290444;701.1025886864821;701.2111374703459;713.1335427455666;720.5136532840312;811.3874025111004;840.315143158324;841.7685136587487;842.1452225990624;866.0776273268948;9602.90397096034;9698.46658433793;9707.757306067404;10136.847947280648;10294.080903480379;854.7563944275852;855.8031652719785;866.3285953386176;879.3053487744738;885.5085427587621;4455.821767129279;4795.95204047962;4807.18277892759;4858.975705121523;4933.136701077297;69502;69968;70030.64984675044;70075.64962175157;71013;57935.13097303544;59178.40821591815;59216.40783592195;59372;60240.397596024355;53244;53604.46395535995;53724;54158.45841541534;54573.181402279;9692.273079518924;9737.22102231834;9803.460809655537;9831.459269740233;9845.360051596623;38686.613133869425;39420.80289598534;39446.40830387604;39804.80097599609;40117.19765604613;44788.55211447974;45016;48378;50950.235746464576;51896.74051629718;12871.163374380636;13011.479540818262;13152.934235329145;13213.537526186537;13254.668633284246;13352.86647133555;13374.264415457243;13394.732105357643;13534.187948723109;13698.45206191741;13501.392437340146;13597.592072237849;13621.863781362455;13636.250006249751;13682;13675.521356752864;13858.861411385757;13964.511242106477;14220.928895355457;14396.064255823338;13113.672158195739;13150.145240559334;13273.933630331787;13290.601281961557;13398.26309552984;10868.456577170951;11008.614698485515;11054.170937179904;11502.712432189262;11549.711257218636;10824.783504330027;11160;11238.606648767582;11490;11525 10:30:40 INFO - PROCESS | 26204 | __end_tp_report 10:30:40 INFO - PROCESS | 26204 | __start_cc_report 10:30:40 INFO - PROCESS | 26204 | _x_x_mozilla_cycle_collect,327 10:30:40 INFO - PROCESS | 26204 | __end_cc_report 10:30:40 INFO - PROCESS | 26204 | __startTimestamp1466703040800__endTimestamp 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | ------- Summary: start ------- 10:30:40 INFO - PROCESS | 26204 | Number of tests: 6 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#0] dojo.html Cycles:165 Average:5699.12 Median:5978.64 stddev:649.61 (10.9%) stddev-sans-first:625.10 10:30:40 INFO - PROCESS | 26204 | Values: 3357.7 3398.3 3408.3 3425.2 3426.2 5625.3 5626.4 5640.2 5659.7 5664.6 5611.8 5622.2 5643.7 5656.9 5676.2 5059.9 5126.9 5128.6 5135.2 5170.4 5124.2 5191.6 5287.5 5297.4 5300.2 5255.7 5282.4 5318.9 5326.0 5344.0 5281.6 5307.4 5312.9 5317.1 5325.5 5035.1 5130.7 5203.5 5218.5 5275.8 5490.2 5492.8 5510.7 5528.3 5549.6 5987.0 6020.1 6040.0 6044.5 6054.8 6086.7 6106.7 6114.8 6120.5 6130.9 5793.1 5796.5 5805.1 5814.2 5829.7 6332.7 6335.2 6337.4 6340.9 6344.4 5850.2 5883.3 5950.1 5985.9 6071.5 6031.8 6047.8 6058.0 6064.2 6076.3 5982.6 6017.6 6043.2 6044.7 6050.7 5987.6 6046.7 6108.8 6118.5 6132.8 4573.2 4595.7 4613.6 4619.0 4638.2 4131.0 4136.3 4145.5 4161.2 4163.4 5799.4 5805.0 5914.6 5975.3 6013.7 6219.6 6239.6 6249.3 6252.2 6266.1 5771.6 5956.2 5971.9 5994.4 6024.3 5233.1 5247.9 5269.8 5302.6 5312.2 6326.3 6341.3 6351.9 6361.1 6362.9 6128.2 6131.9 6134.9 6136.1 6137.4 6379.2 6433.3 6447.0 6498.7 6499.0 6022.1 6059.3 6070.2 6073.1 6091.3 5865.6 6170.5 6178.1 6195.3 6213.7 5991.3 6000.5 6006.0 6050.1 6086.2 6039.6 6040.5 6043.5 6049.8 6053.2 5768.4 5912.3 5963.7 5978.6 6043.7 6045.2 6098.8 6107.8 6117.1 6137.2 5926.3 5972.9 5974.9 5979.0 6004.9 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#1] ext.html Cycles:180 Average:62480.01 Median:45064.71 stddev:121434.75 (269.5%) stddev-sans-first:121686.55 10:30:40 INFO - PROCESS | 26204 | Values: 607.8 642.7 661.3 672.1 678.2 40539.6 40542.0 40613.4 40797.0 40807.6 44591.8 45173.1 45209.3 45253.0 45404.0 8882.0 9067.9 9070.1 9087.5 9090.9 8803.9 8804.2 8837.0 8899.4 8925.3 9196.2 9251.5 9267.1 9280.4 9301.6 9100.2 9216.6 9222.8 9223.6 9234.8 9014.5 9153.8 9161.5 9193.6 9197.0 45541.8 46024.8 46088.5 46105.0 46231.3 3837.8 3959.4 4035.8 4079.0 4347.1 32860.5 33142.8 33261.2 33349.8 33784.7 4535.9 4640.7 4651.3 4667.4 4685.9 291933.0 292033.5 294023.0 295133.0 296154.0 67999.7 68191.3 68395.3 68459.0 68950.3 73549.6 74057.0 74163.0 74359.6 74578.3 18446.4 18825.7 18872.6 18881.4 18992.0 13785.2 13926.8 14004.5 14040.2 14061.9 20723.6 21237.9 21247.2 21257.9 21847.7 7493.4 7509.5 7604.5 7657.2 7849.1 1059.2 1115.1 1125.9 1178.8 1190.9 33939.7 34476.5 34804.8 34822.5 34987.6 1167.0 1214.2 1221.9 1246.3 1281.4 17543.9 17751.0 17888.0 17989.7 18068.8 522938.0 550132.0 551016.0 579075.0 592387.0 60133.0 60862.1 61141.7 61379.7 61474.4 1515.2 1522.0 1522.1 1523.5 1529.1 34827.3 34953.1 35468.0 35602.0 35756.5 58330.7 58382.7 59028.0 59047.4 59125.0 470994.0 478569.0 479345.0 479931.0 481030.0 32557.8 32859.3 33158.8 33231.0 33483.3 53826.2 54173.0 54253.0 54524.7 55231.0 43784.6 44956.3 45882.0 45960.3 46634.8 43830.0 44723.0 44743.7 46119.8 46132.8 40452.0 40942.2 41004.8 41413.2 41623.8 33840.3 34472.8 34607.5 35076.8 35140.8 27470.5 28072.0 29529.4 30068.8 30257.0 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#2] jquery.html Cycles:180 Average:30805.03 Median:12674.84 stddev:89121.60 (703.1%) stddev-sans-first:89342.44 10:30:40 INFO - PROCESS | 26204 | Values: 436.4 444.2 446.5 448.8 455.2 19139.8 19391.5 19735.7 21436.8 21462.5 20053.0 20397.6 20605.0 20612.8 20654.2 5817.2 6054.7 6100.6 6106.4 6106.8 5651.6 5912.3 5980.8 6000.0 6010.6 5506.3 5951.3 5953.6 5980.7 6017.1 5826.1 5834.5 5839.6 5850.7 5860.0 5644.9 5815.1 5943.4 5947.6 5965.9 14883.9 15184.5 15205.5 23120.1 23297.0 2350.8 2383.3 2385.4 2412.1 2468.2 10586.4 10716.2 12333.9 14662.0 14785.3 1983.9 2043.1 2117.0 2127.2 2229.6 69951.3 84841.6 85300.6 85757.6 89113.6 11465.3 11534.8 11686.9 11800.8 12050.3 16396.0 16610.3 16642.9 16708.3 16855.9 8796.3 9109.0 9149.5 9267.7 9298.3 9044.2 9044.5 9057.1 9122.2 9133.7 5106.5 5133.8 5171.7 5184.4 5292.4 1941.2 2056.9 2148.0 2165.5 2218.1 1021.4 1059.4 1083.7 1146.8 1185.7 19000.6 19639.3 19747.3 19917.0 20298.9 1062.3 1073.7 1098.7 1130.9 1133.9 10871.3 11388.3 11507.2 11528.8 11686.4 525530.5 539510.0 540571.0 541878.0 560840.0 96081.5 96749.0 98127.5 98153.0 99547.5 1097.7 1113.7 1123.4 1134.7 1137.4 17257.8 17701.2 17834.7 17895.6 18216.2 36691.8 37096.0 37792.8 37855.8 40908.8 53394.2 55764.7 56468.4 56490.7 56874.4 8665.4 8784.1 8789.6 9008.2 9194.0 9292.2 13597.6 14196.7 14239.2 14240.4 11835.9 12529.0 12751.2 12944.3 13039.5 12466.2 12528.5 12531.5 12618.6 12957.0 11298.3 11471.2 11773.2 11975.5 12983.6 8938.8 9318.1 9392.5 9692.1 9697.7 9051.3 12631.4 12655.2 12705.4 12862.2 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#3] mootools.html Cycles:180 Average:5798.46 Median:4986.54 stddev:3204.97 (64.3%) stddev-sans-first:3198.24 10:30:40 INFO - PROCESS | 26204 | Values: 1575.2 1577.9 1758.8 1906.8 1919.9 7423.3 8170.2 8363.3 8522.9 8549.8 8107.1 8135.4 8179.9 8210.7 8224.2 2397.9 2417.8 2423.8 2431.1 2434.8 2368.4 2372.4 2426.3 2441.3 2444.8 2409.8 2410.8 2437.8 2448.3 2463.4 2369.0 2390.2 2417.5 2428.5 2433.0 2368.4 2379.5 2379.9 2385.5 2393.4 8389.5 8425.2 8439.8 8445.2 8476.1 5409.6 5518.3 5559.6 5560.0 5567.3 3535.1 3600.8 3615.9 3735.1 3772.1 1109.3 1174.3 1178.6 1191.2 1199.9 12205.8 12255.0 12269.0 12294.6 12349.6 4932.8 4956.8 4980.3 5002.9 5013.1 10364.5 10406.9 10429.2 10434.3 10453.5 5480.8 5515.4 5533.4 5535.3 5540.0 4293.0 4890.4 4973.6 4992.8 5018.2 4172.8 4178.2 4221.8 4261.2 4277.6 1396.6 1398.1 1406.7 1413.1 1418.5 964.4 1041.5 1068.4 1074.4 1082.3 5865.8 6045.6 6070.2 6146.6 6198.9 487.8 493.8 495.7 496.8 512.8 3662.8 3691.5 3995.6 4154.6 4202.4 10737.2 10943.4 10958.4 10976.9 10992.3 10569.9 10791.6 10794.7 10799.4 10801.8 8274.2 8445.3 8448.8 8458.7 8469.3 5915.2 6015.0 6051.0 6161.6 6179.2 9465.3 9514.8 9771.0 9795.2 9802.3 9564.3 9845.7 9867.7 10018.2 10033.9 6782.9 7753.0 7833.6 7834.0 7855.9 8323.5 8350.6 8353.6 8372.8 8389.5 7557.6 7700.7 7727.7 7747.5 7844.5 7615.9 7617.2 7705.4 7713.1 7791.7 6830.3 6832.3 6843.9 6850.8 6886.5 5177.7 5206.8 5270.5 5288.9 5331.0 5306.5 5343.2 5409.1 5474.8 5518.3 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#4] prototype.html Cycles:180 Average:5835.19 Median:6688.68 stddev:1796.64 (26.9%) stddev-sans-first:1754.04 10:30:40 INFO - PROCESS | 26204 | Values: 358.8 361.0 365.4 370.7 373.6 6397.9 6444.8 6520.4 6657.5 6667.0 6540.5 6567.5 6587.3 6593.5 6600.4 4993.6 4997.9 4998.7 4999.6 5011.4 4966.1 4970.0 5002.4 5004.3 5006.3 4939.9 4957.2 4968.9 4971.9 4977.9 4734.5 4871.0 4958.2 4961.0 4978.2 4233.1 4244.5 4247.8 4254.0 4254.7 6240.7 6246.3 6254.7 6263.2 6270.1 5707.7 5763.1 5764.1 5774.9 5780.3 6940.7 6942.8 6943.1 6944.0 6964.7 4634.5 4757.7 4773.6 4790.3 4795.8 7155.7 7158.6 7191.1 7233.1 7265.9 4898.7 4907.4 4907.9 4910.1 4921.4 4960.8 4965.7 4966.8 4969.4 4970.5 5754.5 5757.5 5763.7 5772.2 5778.0 6884.7 6985.2 6997.8 7005.4 7007.8 1695.4 1704.5 1714.9 1718.8 1721.6 1029.2 1137.4 1143.2 1153.4 1165.5 6696.6 6867.4 6868.5 6869.8 6890.2 7261.4 7263.7 7264.9 7273.7 7273.7 6867.8 6873.3 6876.5 6880.0 6884.1 3838.2 3889.3 3927.8 3931.0 3935.0 7639.7 7641.4 7643.0 7650.3 7666.2 7362.7 7391.9 7395.3 7404.5 7420.7 7603.0 7613.8 7622.9 7632.5 7633.8 7047.2 7231.2 7232.3 7238.3 7241.0 7060.0 7112.7 7123.6 7139.0 7141.8 7544.7 7554.3 7565.4 7607.4 7608.1 4751.9 4779.8 4788.5 4793.6 4796.0 7096.5 7209.4 7221.2 7222.4 7238.1 6977.0 6995.2 6998.2 7002.9 7012.1 6927.3 6959.1 6976.7 6980.6 6985.1 6810.6 6829.3 6834.7 6844.3 6847.8 6867.2 7009.8 7048.4 7057.2 7082.6 6680.8 6881.1 6943.8 6965.2 6983.8 10:30:40 INFO - PROCESS | 26204 | 10:30:40 INFO - PROCESS | 26204 | [#5] yui.html Cycles:180 Average:15839.67 Median:25403.25 stddev:18454.68 (72.6%) stddev-sans-first:18472.48 10:30:40 INFO - PROCESS | 26204 | Values: 930.6 937.5 957.8 958.3 961.7 14943.9 15126.3 15140.2 15147.0 15190.4 12822.4 14209.1 14264.6 14406.6 14431.4 885.4 904.8 909.8 911.1 911.1 882.1 884.0 889.8 892.0 894.8 934.9 935.8 937.4 941.1 942.3 925.2 925.4 925.5 926.9 927.9 686.4 687.6 687.6 688.1 690.2 13597.5 13617.9 13629.5 13653.5 13722.2 12890.7 13084.9 13095.0 13159.2 13164.8 10893.3 10893.7 10909.5 11012.1 11107.8 3993.6 4043.7 4072.8 4110.2 4123.7 46010.5 49141.8 53925.0 54766.2 65257.7 12404.9 12499.4 12556.2 12690.6 12799.9 21908.9 21913.2 21914.1 21937.5 21950.6 9052.4 9323.8 9328.9 9401.4 9666.6 5016.2 5071.1 5124.1 5154.5 5220.3 3576.1 3622.2 3633.2 3634.7 3638.6 686.3 701.1 701.2 713.1 720.5 811.4 840.3 841.8 842.1 866.1 9602.9 9698.5 9707.8 10136.8 10294.1 854.8 855.8 866.3 879.3 885.5 4455.8 4796.0 4807.2 4859.0 4933.1 69502.0 69968.0 70030.6 70075.6 71013.0 57935.1 59178.4 59216.4 59372.0 60240.4 53244.0 53604.5 53724.0 54158.5 54573.2 9692.3 9737.2 9803.5 9831.5 9845.4 38686.6 39420.8 39446.4 39804.8 40117.2 44788.6 45016.0 48378.0 50950.2 51896.7 12871.2 13011.5 13152.9 13213.5 13254.7 13352.9 13374.3 13394.7 13534.2 13698.5 13501.4 13597.6 13621.9 13636.3 13682.0 13675.5 13858.9 13964.5 14220.9 14396.1 13113.7 13150.1 13273.9 13290.6 13398.3 10868.5 11008.6 11054.2 11502.7 11549.7 10824.8 11160.0 11238.6 11490.0 11525.0 10:30:40 INFO - PROCESS | 26204 | -------- Summary: end -------- 10:30:40 INFO - PROCESS | 26204 | 10:30:41 INFO - TEST-INFO | 26204: exit 0 10:30:41 INFO - TEST-OK | dromaeo_css | took 1108132ms 10:30:41 INFO - TEST-START | kraken 10:30:41 INFO - operating with platform_type : linux_ 10:30:41 INFO - Initialising browser for kraken test... 10:30:41 INFO - TEST-INFO | started process 26446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmTV__/profile http://localhost:56829/getInfo.html) 10:30:44 INFO - PROCESS | 26446 | 10:30:44 INFO - PROCESS | 26446 | (process:26526): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:45 INFO - PROCESS | 26446 | __metrics Screen width/height:1600/1200 10:30:45 INFO - PROCESS | 26446 | colorDepth:24 10:30:45 INFO - PROCESS | 26446 | Browser inner width/height: 1024/697 10:30:45 INFO - PROCESS | 26446 | __metrics 10:30:45 ERROR - PROCESS | 26446 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:30:46 INFO - TEST-INFO | 26446: exit 0 10:30:46 INFO - Browser initialized. 10:30:46 INFO - Running cycle 1/1 for kraken test... 10:30:46 INFO - TEST-INFO | started process 26577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmTV__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:48 INFO - PROCESS | 26577 | 10:30:48 INFO - PROCESS | 26577 | (process:26644): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:58 INFO - PROCESS | 26577 | RSS: Main: 150908928 10:30:58 INFO - PROCESS | 26577 | 10:31:00 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56829/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:01 INFO - PROCESS | 26577 | RSS: Main: 156418048 10:31:01 INFO - PROCESS | 26577 | 10:31:04 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56829/tests/kraken/driver.html?testName=audio-dft) 10:31:05 INFO - PROCESS | 26577 | RSS: Main: 156225536 10:31:05 INFO - PROCESS | 26577 | 10:31:07 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56829/tests/kraken/driver.html?testName=audio-fft) 10:31:08 INFO - PROCESS | 26577 | RSS: Main: 156758016 10:31:08 INFO - PROCESS | 26577 | 10:31:10 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56829/tests/kraken/driver.html?testName=audio-oscillator) 10:31:11 INFO - PROCESS | 26577 | RSS: Main: 156704768 10:31:11 INFO - PROCESS | 26577 | 10:31:13 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56829/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:13 INFO - PROCESS | 26577 | RSS: Main: 156372992 10:31:13 INFO - PROCESS | 26577 | 10:31:17 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56829/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:17 INFO - PROCESS | 26577 | RSS: Main: 157368320 10:31:17 INFO - PROCESS | 26577 | 10:31:20 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56829/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:21 INFO - PROCESS | 26577 | RSS: Main: 156803072 10:31:21 INFO - PROCESS | 26577 | 10:31:24 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56829/tests/kraken/driver.html?testName=json-parse-financial) 10:31:24 INFO - PROCESS | 26577 | RSS: Main: 156831744 10:31:24 INFO - PROCESS | 26577 | 10:31:26 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56829/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:27 INFO - PROCESS | 26577 | RSS: Main: 156389376 10:31:27 INFO - PROCESS | 26577 | 10:31:28 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:29 INFO - PROCESS | 26577 | RSS: Main: 156577792 10:31:29 INFO - PROCESS | 26577 | 10:31:31 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:32 INFO - PROCESS | 26577 | RSS: Main: 156987392 10:31:32 INFO - PROCESS | 26577 | 10:31:34 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:35 INFO - PROCESS | 26577 | RSS: Main: 157540352 10:31:35 INFO - PROCESS | 26577 | 10:31:37 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:38 INFO - PROCESS | 26577 | RSS: Main: 157143040 10:31:38 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | Cycle 1(1): loaded http://localhost:56829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56829/tests/kraken/driver.html?testName=ai-astar) 10:31:40 INFO - PROCESS | 26577 | RSS: Main: 158511104 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | __start_tp_report 10:31:40 INFO - PROCESS | 26577 | _x_x_mozilla_page_load 10:31:40 INFO - PROCESS | 26577 | _x_x_mozilla_page_load_details 10:31:40 INFO - PROCESS | 26577 | |i|pagename|runs| 10:31:40 INFO - PROCESS | 26577 | |0;ai-astar;110;112;102;110;112;112;109;110;110;111 10:31:40 INFO - PROCESS | 26577 | |1;audio-beat-detection;174;138;156;173;131;159;149;127;173;129 10:31:40 INFO - PROCESS | 26577 | |2;audio-dft;163;163;163;162;162;163;164;163;162;161 10:31:40 INFO - PROCESS | 26577 | |3;audio-fft;77;74;77;183;75;74;76;77;157;74 10:31:40 INFO - PROCESS | 26577 | |4;audio-oscillator;92;92;161;92;94;93;160;92;93;148 10:31:40 INFO - PROCESS | 26577 | |5;imaging-gaussian-blur;117;118;116;118;117;117;117;118;117;117 10:31:40 INFO - PROCESS | 26577 | |6;imaging-darkroom;146;147;146;146;145;145;150;146;147;147 10:31:40 INFO - PROCESS | 26577 | |7;imaging-desaturate;97;101;96;96;95;95;95;95;94;95 10:31:40 INFO - PROCESS | 26577 | |8;json-parse-financial;62;56;68;58;58;58;60;77;59;55 10:31:40 INFO - PROCESS | 26577 | |9;json-stringify-tinderbox;57;59;58;59;59;58;58;57;58;58 10:31:40 INFO - PROCESS | 26577 | |10;stanford-crypto-aes;72;73;77;74;73;75;81;74;74;73 10:31:40 INFO - PROCESS | 26577 | |11;stanford-crypto-ccm;117;125;128;118;113;113;114;118;128;133 10:31:40 INFO - PROCESS | 26577 | |12;stanford-crypto-pbkdf2;156;156;161;157;156;160;160;155;160;162 10:31:40 INFO - PROCESS | 26577 | |13;stanford-crypto-sha256-iterative;68;68;68;67;68;66;64;66;70;65 10:31:40 INFO - PROCESS | 26577 | __end_tp_report 10:31:40 INFO - PROCESS | 26577 | __start_cc_report 10:31:40 INFO - PROCESS | 26577 | _x_x_mozilla_cycle_collect,838 10:31:40 INFO - PROCESS | 26577 | __end_cc_report 10:31:40 INFO - PROCESS | 26577 | __startTimestamp1466703100423__endTimestamp 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | ------- Summary: start ------- 10:31:40 INFO - PROCESS | 26577 | Number of tests: 14 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.94 (2.7%) stddev-sans-first:3.11 10:31:40 INFO - PROCESS | 26577 | Values: 110.0 112.0 102.0 110.0 112.0 112.0 109.0 110.0 110.0 111.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:157.50 stddev:18.91 (12.0%) stddev-sans-first:18.12 10:31:40 INFO - PROCESS | 26577 | Values: 174.0 138.0 156.0 173.0 131.0 159.0 149.0 127.0 173.0 129.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 10:31:40 INFO - PROCESS | 26577 | Values: 163.0 163.0 163.0 162.0 162.0 163.0 164.0 163.0 162.0 161.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:40.33 (53.4%) stddev-sans-first:42.28 10:31:40 INFO - PROCESS | 26577 | Values: 77.0 74.0 77.0 183.0 75.0 74.0 76.0 77.0 157.0 74.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:30.99 (33.7%) stddev-sans-first:32.04 10:31:40 INFO - PROCESS | 26577 | Values: 92.0 92.0 161.0 92.0 94.0 93.0 160.0 92.0 93.0 148.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:31:40 INFO - PROCESS | 26577 | Values: 117.0 118.0 116.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.43 (1.0%) stddev-sans-first:1.51 10:31:40 INFO - PROCESS | 26577 | Values: 146.0 147.0 146.0 146.0 145.0 145.0 150.0 146.0 147.0 147.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:1.97 (2.1%) stddev-sans-first:2.05 10:31:40 INFO - PROCESS | 26577 | Values: 97.0 101.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:59.50 stddev:6.66 (11.2%) stddev-sans-first:7.05 10:31:40 INFO - PROCESS | 26577 | Values: 62.0 56.0 68.0 58.0 58.0 58.0 60.0 77.0 59.0 55.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 10:31:40 INFO - PROCESS | 26577 | Values: 57.0 59.0 58.0 59.0 59.0 58.0 58.0 57.0 58.0 58.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:2.63 (3.6%) stddev-sans-first:2.62 10:31:40 INFO - PROCESS | 26577 | Values: 72.0 73.0 77.0 74.0 73.0 75.0 81.0 74.0 74.0 73.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:7.21 (5.9%) stddev-sans-first:7.52 10:31:40 INFO - PROCESS | 26577 | Values: 117.0 125.0 128.0 118.0 113.0 113.0 114.0 118.0 128.0 133.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:160.00 stddev:2.54 (1.6%) stddev-sans-first:2.55 10:31:40 INFO - PROCESS | 26577 | Values: 156.0 156.0 161.0 157.0 156.0 160.0 160.0 155.0 160.0 162.0 10:31:40 INFO - PROCESS | 26577 | 10:31:40 INFO - PROCESS | 26577 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.76 (2.6%) stddev-sans-first:1.83 10:31:40 INFO - PROCESS | 26577 | Values: 68.0 68.0 68.0 67.0 68.0 66.0 64.0 66.0 70.0 65.0 10:31:40 INFO - PROCESS | 26577 | -------- Summary: end -------- 10:31:40 INFO - PROCESS | 26577 | 10:31:41 INFO - TEST-INFO | 26577: exit 0 10:31:41 INFO - TEST-OK | kraken | took 60019ms 10:31:41 INFO - SUITE-END | took 1168s 10:31:41 INFO - Completed test suite (00:19:28) 10:31:41 INFO - javascript benchmark 10:31:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.748168887333, 3398.3373242217776, 3408.3012982338614, 3425.2122011937267, 3426.246225830318, 5625.32496100468, 5626.409227031159, 5640.210370548127, 5659.66042037478, 5664.575156863231, 5611.80358687446, 5622.240997465341, 5643.717814109299, 5656.858578535539, 5676.205331253617, 5059.873503162423, 5126.948730512703, 5128.615353848458, 5135.204043373283, 5170.353705786777, 5124.154514505102, 5191.636585439021, 5287.4976877196605, 5297.390800057985, 5300.151975683892, 5255.684658920458, 5282.3925248596515, 5318.867028324304, 5326.041312563737, 5344.038073146832, 5281.603879709018, 5307.442718514559, 5312.893742125175, 5317.12267475866, 5325.547328477084, 5035.093683137071, 5130.71781052042, 5203.453637368098, 5218.452062533417, 5275.815346462856, 5490.231367608538, 5492.835214943558, 5510.724463776795, 5528.281323427969, 5549.556035517149, 5986.97006514969, 6020.096985452174, 6039.969800151015, 6044.455998960071, 6054.8183554493435, 6086.6956652167655, 6106.72519736613, 6114.785982490592, 6120.510359171256, 6130.917941863022, 5793.13103034544, 5796.478316951495, 5805.10020946754, 5814.156947242668, 5829.737661805187, 6332.68336583169, 6335.208098987627, 6337.366263373626, 6340.873182536324, 6344.397282258178, 5850.180974663551, 5883.3234178069215, 5950.107483877367, 5985.880282394328, 6071.51427885768, 6031.819045428644, 6047.758089676364, 6057.97014507526, 6064.211652485237, 6076.270847498328, 5982.611130276518, 6017.608855424383, 6043.153958445821, 6044.667543285073, 6050.727717252734, 5987.64074155552, 6046.697665116727, 6108.847278818065, 6118.4668989547035, 6132.78385080153, 4573.153966516205, 4595.747233902101, 4613.607843333354, 4618.97690511552, 4638.1883170445035, 4131.0, 4136.276151673445, 4145.461090058273, 4161.167766446722, 4163.417121602917, 5799.420057994251, 5805.0, 5914.615549989237, 5975.282966044103, 6013.6993150342305, 6219.626822390671, 6239.563230573816, 6249.25008998923, 6252.218472690914, 6266.122742816009, 5771.595988280864, 5956.225690660186, 5971.940280597139, 5994.381516990476, 6024.277086749618, 5233.1365324721755, 5247.921281180786, 5269.841904742864, 5302.628815982921, 5312.150055991023, 6326.304106548276, 6341.302456729756, 6351.872962540723, 6361.077643741632, 6362.9045564316575, 6128.233970753656, 6131.908021379593, 6134.9079763804475, 6136.140940268366, 6137.407629318989, 6379.234491861006, 6433.260175079926, 6446.967765161145, 6498.74005039812, 6499.025146228104, 6022.066579680157, 6059.33347331802, 6070.2412198475195, 6073.119397687399, 6091.329953705177, 5865.618734782225, 6170.475509581556, 6178.1350610913605, 6195.318514963441, 6213.689315534115, 5991.310999235144, 6000.489958353589, 6005.969970150121, 6050.062240352752, 6086.239220097488, 6039.63762174271, 6040.516758659384, 6043.486303664238, 6049.818505444844, 6053.182820319201, 5768.394318596487, 5912.260967379078, 5963.701814909324, 5978.641281523122, 6043.697815109315, 6045.183900173421, 6098.817035488943, 6107.816765497042, 6117.1130186123655, 6137.232845894263, 5926.288845338587, 5972.940270597239, 5974.850628734316, 5979.013462778767, 6004.939950600613], "value": 5655.610774535829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7963882099497, 642.7461152844627, 661.2692974263439, 672.0792514255473, 678.2098854834119, 40539.59460405395, 40542.0, 40613.39079913804, 40797.0, 40807.591924080785, 44591.77704111483, 45173.09653806922, 45209.321860172124, 45253.0, 45404.0, 8882.0, 9067.909320906805, 9070.138336857988, 9087.545622718872, 9090.863637045417, 8803.911960880374, 8804.207621314112, 8836.955815220916, 8899.37704360695, 8925.285977121815, 9196.172344488994, 9251.491167985758, 9267.073292670713, 9280.35037547372, 9301.627934882597, 9100.180983711465, 9216.631334746602, 9222.815543689123, 9223.631054757769, 9234.769130771718, 9014.459132452008, 9153.81692366149, 9161.496117713523, 9193.586288617029, 9197.0, 45541.772291138666, 46024.76987615074, 46088.53911460876, 46105.0, 46231.30653040207, 3837.76973381598, 3959.4060890866313, 4035.7578545287083, 4079.0, 4347.108842687241, 32860.50709239364, 33142.834285828416, 33261.16847078818, 33349.83325083359, 33784.6621533784, 4535.863924082283, 4640.744759038252, 4651.348811166439, 4667.369905062807, 4685.882852928704, 291933.0, 292033.5398323016, 294023.0, 295133.0, 296154.0, 67999.66000169968, 68191.3180868185, 68395.31604683989, 68459.0, 68950.3104968954, 73549.63225183947, 74057.0, 74163.0, 74359.62820185865, 74578.25421745822, 18446.35437759672, 18825.717614235797, 18872.622547549247, 18881.433556993314, 18992.0, 13785.172889626454, 13926.791098133535, 14004.509842155476, 14040.1575905446, 14061.859381406055, 20723.58552828935, 21237.893810530848, 21247.150113995267, 21257.89371053135, 21847.672284915738, 7493.4005279577505, 7509.474336796481, 7604.528528228348, 7657.157712651604, 7849.058113026474, 1059.2108878885126, 1115.0912006714502, 1125.8648962124598, 1178.8290697848763, 1190.8746234808023, 33939.66060339414, 34476.48285275723, 34804.825975870466, 34822.47766283508, 34987.61773101133, 1166.988330116688, 1214.2410993129295, 1221.877812218771, 1246.2522486508024, 1281.3529167770216, 17543.912280438515, 17751.0, 17888.0, 17989.7301540477, 18068.819311806714, 522938.0, 550132.0, 551016.0, 579075.0, 592387.0, 60133.0, 60862.087068694, 61141.694291529144, 61379.6931015351, 61474.38525614776, 1515.2348064227715, 1522.0335087219473, 1522.0715363628178, 1523.5200911712775, 1529.0596283285922, 34827.30345393129, 34953.126171845906, 35468.0, 35602.0, 35756.46365304574, 58330.708346458, 58382.708086460996, 59028.0, 59047.40952590419, 59125.0, 470994.0, 478569.0, 479345.0, 479931.0, 481030.0, 32557.83721081474, 32859.34281314408, 33158.83420582882, 33231.0, 33483.330333393686, 53826.19260711014, 54173.0, 54253.0, 54524.72737636286, 55231.0, 43784.56215437805, 44956.325655115856, 45882.0, 45960.31059534177, 46634.76682616701, 43830.0, 44723.0, 44743.72241135401, 46119.76940115278, 46132.769336153106, 40452.0, 40942.1811563773, 41004.794976026125, 41413.171736564494, 41623.7918810404, 33840.3231935355, 34472.79345222905, 34607.480887787206, 35076.82461587676, 35140.82429587836, 27470.45059098847, 28072.0, 29529.409411811215, 30068.849655751583, 30257.0], "value": 21495.9850239759, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.42392042503906, 444.1538868455591, 446.5445245849234, 448.7860337786288, 455.19885002395796, 19139.808601913977, 19391.515212119688, 19735.703964440527, 21436.785632143674, 21462.463438414048, 20053.0, 20397.59204815903, 20605.0, 20612.793872061276, 20654.173833046698, 5817.214676018736, 6054.666993315366, 6100.603460775058, 6106.358832322609, 6106.786262480814, 5651.5761317901115, 5912.260967379078, 5980.820575382745, 5999.970000149993, 6010.609310394832, 5506.284183056197, 5951.345352011275, 5953.553483488734, 5980.684249465133, 6017.097435384705, 5826.067829147359, 5834.474897259267, 5839.591228613998, 5850.707464626752, 5860.003799354099, 5644.943550564483, 5815.098659707752, 5943.4056594340655, 5947.5539334550085, 5965.850853728648, 14883.851161488356, 15184.544463665998, 15205.467808626645, 23120.0751969921, 23297.0, 2350.788429041377, 2383.3088404362716, 2385.415573184581, 2412.143688990418, 2468.1978357034036, 10586.41774702391, 10716.196285278635, 12333.876661233453, 14662.046966947115, 14785.334659940328, 1983.8710483818506, 2043.090824583061, 2117.0, 2127.191667166482, 2229.598672238996, 69951.300486995, 84841.57579212064, 85300.57349713212, 85757.57121214416, 89113.55443222808, 11465.312081274984, 11534.826977595343, 11686.88313116875, 11800.763984720257, 12050.337231452355, 16396.0, 16610.25253863555, 16642.916785416237, 16708.331666733437, 16855.915720421566, 8796.252318552866, 9109.0, 9149.542522873962, 9267.67563135287, 9298.257014180834, 9044.186023257938, 9044.547772611342, 9057.09429057089, 9122.179003889682, 9133.72598822023, 5106.540411362995, 5133.820316288912, 5171.68969861802, 5184.403793563789, 5292.417834038252, 1941.2041063164318, 2056.8868712220674, 2148.0, 2165.5019345550613, 2218.1460137847043, 1021.4075836015094, 1059.3749687684149, 1083.6803143072655, 1146.7649131928101, 1185.6917201527665, 19000.61998760017, 19639.31262405809, 19747.308844190673, 19917.0, 20298.89850550738, 1062.3094988257694, 1073.7423018475665, 1098.6649072033106, 1130.9151813614012, 1133.863936327646, 10871.29336593119, 11388.259763115371, 11507.194496385173, 11528.827067593993, 11686.357250351311, 525530.5009967963, 539510.0, 540571.0, 541878.0, 560840.0, 96081.51959240298, 96749.0, 98127.50936245416, 98153.0, 99547.50226248823, 1097.7255686078481, 1113.732704151014, 1123.4158237716342, 1134.744682446443, 1137.3687603380038, 17257.79195456306, 17701.20344584471, 17834.732479013084, 17895.642087157925, 18216.180271887533, 36691.81654091713, 37096.0, 37792.811035944644, 37855.81072094622, 40908.795456022526, 53394.1990870145, 55764.72117639386, 56468.43531564796, 56490.71754641201, 56874.43125568691, 8665.43674661145, 8784.121587841164, 8789.648414063366, 9008.189262966365, 9194.0, 9292.236644159126, 13597.592072237849, 14196.722294993087, 14239.216843073731, 14240.430382784572, 11835.940820295844, 12529.0, 12751.234925904475, 12944.288064156184, 13039.478420863059, 12466.189697669623, 12528.498860045496, 12531.498740050296, 12618.55835045769, 12956.963442924354, 11298.265612735146, 11471.197016208785, 11773.234739741889, 11975.461104250504, 12983.610491685264, 8938.821223575362, 9318.114779095975, 9392.530373481435, 9692.127708506268, 9697.709068727949, 9051.31000562525, 12631.431585578855, 12655.240685558896, 12705.42825572833, 12862.228266304051], "value": 9708.841395897867, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.204521716533, 1577.8816588755842, 1758.8241175882413, 1906.8379187769049, 1919.9424017279487, 7423.29478699524, 8170.223828736261, 8363.289120424764, 8522.87215691765, 8549.786255343619, 8107.108218096005, 8135.4305198635975, 8179.91820081799, 8210.712625058124, 8224.177582241773, 2397.868117253555, 2417.782399584037, 2423.7697418745192, 2431.0761910473993, 2434.7565243475688, 2368.3842201027683, 2372.4424760181346, 2426.3206302235403, 2441.2554170977846, 2444.816638752092, 2409.8192635552405, 2410.8312418130736, 2437.81716371272, 2448.3267101547126, 2463.4087818923417, 2368.9644655330185, 2390.187336305647, 2417.492326611414, 2428.453597940458, 2432.9878350608224, 2368.396059004943, 2379.48840999186, 2379.8691071991034, 2385.4632707640817, 2393.4255778613183, 8389.496630202208, 8425.241728244426, 8439.83120337596, 8445.155484451567, 8476.110008449148, 5409.56723462122, 5518.310211223597, 5559.555235581144, 5559.999200143972, 5567.2762540869835, 3535.1338921964284, 3600.819959002066, 3615.927681446383, 3735.1035751419736, 3772.0758414188426, 1109.290054365207, 1174.3130268792765, 1178.6169494914186, 1191.2197510630465, 1199.91023115478, 12205.755884882252, 12255.0, 12268.99999999991, 12294.631161065183, 12349.567765128268, 4932.778024988884, 4956.776945037482, 4980.302757613937, 5002.924956125661, 5013.097642424325, 10364.481775911174, 10406.947965260277, 10429.165666746641, 10434.321769085136, 10453.529591168415, 5480.780768769205, 5515.420880807457, 5533.418991005887, 5535.252740880011, 5540.030494663418, 4292.978535107367, 4890.364252647204, 4973.55238028572, 4992.775325110379, 5018.172001619765, 4172.7913604319665, 4178.185253875526, 4221.78891055446, 4261.169072030986, 4277.567015049931, 1396.6298930783148, 1398.0772690024535, 1406.7116241170536, 1413.0885578801615, 1418.5106138382241, 964.4358050540512, 1041.520900385831, 1068.3643232276784, 1074.3929679730927, 1082.3397727386289, 5865.794697185578, 6045.576809623372, 6070.2108725865355, 6146.6004709693725, 6198.907016394758, 487.81219230595764, 493.75065591875875, 495.6679025053223, 496.7565892712545, 512.8487096306599, 3662.8351724172476, 3691.53855768029, 3995.580464051291, 4154.619767401223, 4202.432671589358, 10737.194710396752, 10943.398113103856, 10958.397288149228, 10976.890231097746, 10992.28550144238, 10569.894301056891, 10791.6222932197, 10794.73013174677, 10799.406032668121, 10801.783964320826, 8274.172582741678, 8445.282151017109, 8448.78878028042, 8458.746237613004, 8469.32245420365, 5915.171875937286, 6015.0, 6051.0, 6161.568690191643, 6179.16581261524, 9465.290103242147, 9514.809703806024, 9770.951145244228, 9795.16741076988, 9802.26483013791, 9564.282678798978, 9845.704628861145, 9867.654632087842, 10018.248631352531, 10033.949830250802, 6782.864342713019, 7753.0, 7833.569153696373, 7834.0, 7855.882161767464, 8323.500589964622, 8350.58247087631, 8353.582320884054, 8372.790680233044, 8389.496630202208, 7557.622118894144, 7700.691972321044, 7727.729529466442, 7747.45050989793, 7844.4901081429525, 7615.885761713468, 7617.200193979553, 7705.383569314329, 7713.112992005991, 7791.727289544839, 6830.282820303796, 6832.316768323128, 6843.931560684329, 6850.828729281808, 6886.48351373639, 5177.715225662625, 5206.791728330824, 5270.472952704698, 5288.9471105289995, 5330.9733451332495, 5306.54894333986, 5343.198520221998, 5409.107497263065, 5474.835754927359, 5518.255035570147], "value": 4642.366015661251, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.84210947183254, 360.9873654422096, 365.4043908429263, 370.7219585311017, 373.57599124993135, 6397.904031439521, 6444.838879028027, 6520.44576211022, 6657.533972621913, 6666.966665166673, 6540.542162048659, 6567.507436942225, 6587.3412658734105, 6593.53845230834, 6600.405963463288, 4993.6005119590345, 4997.850064498062, 4998.6750861193905, 4999.550040496355, 5011.423686276088, 4966.056449274644, 4969.950300496985, 5002.424721157059, 5004.274380214885, 5006.299118123466, 4939.937913348629, 4957.206846904496, 4968.87577810554, 4971.925421118686, 4977.925331120036, 4734.455537613184, 4871.0, 4958.206686930092, 4961.032598643266, 4978.153713868633, 4233.1322078973735, 4244.469441319835, 4247.787610619487, 4254.000309927164, 4254.744715317091, 6240.656763877985, 6246.281677607042, 6254.655993920333, 6263.185785847811, 6270.122182894398, 5707.6575405475805, 5763.1355296705415, 5764.106563482625, 5774.855628609276, 5780.335261444903, 6940.6529673516125, 6942.757003504904, 6943.097397338364, 6943.9652801735665, 6964.651767411609, 4634.467036290836, 4757.690750101232, 4773.618110551148, 4790.329353890458, 4795.832145874912, 7155.67799449026, 7158.570485770871, 7191.137063552354, 7233.095863017175, 7265.927340726578, 4898.681585696918, 4907.411110666742, 4907.901841963141, 4910.091633047898, 4921.434035085939, 4960.801567937242, 4965.652404331662, 4966.826161084345, 4969.403671559436, 4970.52779985908, 5754.510866576305, 5757.481826635623, 5763.682997435098, 5772.220750198753, 5778.0, 6884.65576721172, 6985.231624521299, 6997.755078572225, 7005.404540614105, 7007.824804379829, 1695.3557648093645, 1704.4971733338696, 1714.9228284727217, 1718.8109307976113, 1721.5610019444962, 1029.1766586730585, 1137.4312843578211, 1143.17691262291, 1153.4463457540428, 1165.4988355007429, 6696.59820410777, 6867.381935625718, 6868.484863635247, 6869.7595584154315, 6890.1731792184255, 7261.3827824634445, 7263.7457688981685, 7264.927350726425, 7273.745418910313, 7273.745418910418, 6867.759628413081, 6873.2783057778215, 6876.518643694893, 6880.0, 6884.105066341343, 3838.213166300902, 3889.3193691103943, 3927.7839718815167, 3931.0, 3934.9606503935165, 7639.732609358646, 7641.426892982938, 7643.0, 7650.349720273728, 7666.156722760492, 7362.705491780269, 7391.852162956819, 7395.297446742551, 7404.518706284182, 7420.666070026862, 7602.961985190039, 7613.771586852404, 7622.923770762332, 7632.503887247422, 7633.809154771064, 7047.224805271314, 7231.16841563227, 7232.276772322725, 7238.312360325761, 7240.96379518099, 7059.964700176466, 7112.715491380287, 7123.608201548965, 7138.964305178441, 7141.750038748619, 7544.698212071456, 7554.3201111898, 7565.356944659766, 7607.429442791702, 7608.125065617525, 4751.904961900812, 4779.784909679142, 4788.521147885183, 4793.640476964172, 4796.0, 7096.467764917755, 7209.35115839577, 7221.205667376479, 7222.422206223595, 7238.0952380952385, 6976.965115174392, 6995.195552511323, 6998.195207551197, 7002.894956575554, 7012.053372794608, 6927.3419025192525, 6959.130108736408, 6976.6860491277, 6980.616066116412, 6985.057017302599, 6810.5913645181445, 6829.317068293131, 6834.658267086726, 6844.315568443315, 6847.760328388483, 6867.244603093556, 7009.754658586925, 7048.436125110082, 7057.153141623038, 7082.610456424946, 6680.766173183915, 6881.10545629065, 6943.756968506078, 6965.164180298397, 6983.790486285419], "value": 5244.694884295328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.6324002019203, 937.5031233446274, 957.8323793336165, 958.2908647600773, 961.6922584772875, 14943.850561494382, 15126.319315630795, 15140.167290799001, 15147.0, 15190.392384304629, 12822.422990965406, 14209.147451152938, 14264.572062838106, 14406.639834004156, 14431.350589223484, 885.4465958775766, 904.8235594059161, 909.781652403425, 911.079809392515, 911.0980129671643, 882.1046637662778, 883.9646414143426, 889.8042430665244, 891.9643214271422, 894.8299823033635, 934.9158575728183, 935.7847695030147, 937.4328531238571, 941.0589410589411, 942.2885721280423, 925.2181906289209, 925.3938670171049, 925.5187302602643, 926.8517037274038, 927.9257659387233, 686.3994005245411, 687.5530904911798, 687.6252442418894, 688.0607970120799, 690.1890278922247, 13597.524086657018, 13617.863821361758, 13629.454821807116, 13653.522126725517, 13722.176669399769, 12890.742185156338, 13084.869151308556, 13095.017873659513, 13159.210447373189, 13164.802527962089, 10893.346399216072, 10893.727656808564, 10909.454527273605, 11012.063974562172, 11107.83338249927, 3993.560708322082, 4043.716939814214, 4072.75563466193, 4110.219058378899, 4123.711340206187, 46010.53989460096, 49141.75429122867, 53925.0, 54766.178507322424, 65257.67371163114, 12404.937975310066, 12499.437525311201, 12556.246625202517, 12690.555830545887, 12799.936000319938, 21908.890455547622, 21913.233036843634, 21914.12343506274, 21937.451563711034, 21950.560988780137, 9052.411593246417, 9323.813523729488, 9328.906710932939, 9401.435913845191, 9666.613335466644, 5016.2224855147515, 5071.087204303187, 5124.128898087334, 5154.5360917516855, 5220.295260139833, 3576.0523461282783, 3622.221222437136, 3633.2006958469096, 3634.6547078028075, 3638.599754027055, 686.3479694290444, 701.1025886864821, 701.2111374703459, 713.1335427455666, 720.5136532840312, 811.3874025111004, 840.315143158324, 841.7685136587487, 842.1452225990624, 866.0776273268948, 9602.90397096034, 9698.46658433793, 9707.757306067404, 10136.847947280648, 10294.080903480379, 854.7563944275852, 855.8031652719785, 866.3285953386176, 879.3053487744738, 885.5085427587621, 4455.821767129279, 4795.95204047962, 4807.18277892759, 4858.975705121523, 4933.136701077297, 69502.0, 69968.0, 70030.64984675044, 70075.64962175157, 71013.0, 57935.13097303544, 59178.40821591815, 59216.40783592195, 59372.0, 60240.397596024355, 53244.0, 53604.46395535995, 53724.0, 54158.45841541534, 54573.181402279, 9692.273079518924, 9737.22102231834, 9803.460809655537, 9831.459269740233, 9845.360051596623, 38686.613133869425, 39420.80289598534, 39446.40830387604, 39804.80097599609, 40117.19765604613, 44788.55211447974, 45016.0, 48378.0, 50950.235746464576, 51896.74051629718, 12871.163374380636, 13011.479540818262, 13152.934235329145, 13213.537526186537, 13254.668633284246, 13352.86647133555, 13374.264415457243, 13394.732105357643, 13534.187948723109, 13698.45206191741, 13501.392437340146, 13597.592072237849, 13621.863781362455, 13636.250006249751, 13682.0, 13675.521356752864, 13858.861411385757, 13964.511242106477, 14220.928895355457, 14396.064255823338, 13113.672158195739, 13150.145240559334, 13273.933630331787, 13290.601281961557, 13398.26309552984, 10868.456577170951, 11008.614698485515, 11054.170937179904, 11502.712432189262, 11549.711257218636, 10824.783504330027, 11160.0, 11238.606648767582, 11490.0, 11525.0], "value": 7288.078536338906, "unit": "score"}], "name": "dromaeo_css", "value": 7706.421203836173, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 102.0, 110.0, 112.0, 112.0, 109.0, 110.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 138.0, 156.0, 173.0, 131.0, 159.0, 149.0, 127.0, 173.0, 129.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 163.0, 164.0, 163.0, 162.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 183.0, 75.0, 74.0, 76.0, 77.0, 157.0, 74.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 161.0, 92.0, 94.0, 93.0, 160.0, 92.0, 93.0, 148.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 145.0, 150.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 101.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 56.0, 68.0, 58.0, 58.0, 58.0, 60.0, 77.0, 59.0, 55.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 77.0, 74.0, 73.0, 75.0, 81.0, 74.0, 74.0, 73.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 125.0, 128.0, 118.0, 113.0, 113.0, 114.0, 118.0, 128.0, 133.0], "value": 120.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 161.0, 157.0, 156.0, 160.0, 160.0, 155.0, 160.0, 162.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 66.0, 64.0, 66.0, 70.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1528.7999999999997, "alertThreshold": 2.0}]} 10:31:41 INFO - Return code: 0 10:31:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:31:41 ERROR - # TBPL SUCCESS # 10:31:41 INFO - Running post-action listener: _resource_record_post_action 10:31:41 INFO - Running post-run listener: _resource_record_post_run 10:31:42 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 472637440; Read time: 0; Write time: 384780 10:31:42 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 249393152; Read time: 0; Write time: 224296 10:31:42 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 223244288; Read time: 0; Write time: 160484 10:31:42 INFO - Running post-run listener: _upload_blobber_files 10:31:42 INFO - Blob upload gear active. 10:31:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:42 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 10:31:42 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'] 10:31:42 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 10:31:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:31:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:44 INFO - (blobuploader) - INFO - Done attempting. 10:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:31:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:44 INFO - (blobuploader) - INFO - Done attempting. 10:31:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:44 INFO - Return code: 0 10:31:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b72775424cfbd2cdbc3f6dbcfb33ac5fd5f0c140817d1f1049f1c7601aa218181363473c8453e26d20bc00af5aa3756e99733b5b39ec1cbfcca3db78ec838ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b16e353d9653a2ae78fd0c9ab464dd4d69a79283542df9fe855d38a8c26cbe75b5156ddfbab6638c92307762a0d02d89ed9962d08734c701989c0b3f20fde60"} 10:31:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:44 INFO - Contents: 10:31:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b72775424cfbd2cdbc3f6dbcfb33ac5fd5f0c140817d1f1049f1c7601aa218181363473c8453e26d20bc00af5aa3756e99733b5b39ec1cbfcca3db78ec838ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b16e353d9653a2ae78fd0c9ab464dd4d69a79283542df9fe855d38a8c26cbe75b5156ddfbab6638c92307762a0d02d89ed9962d08734c701989c0b3f20fde60"} 10:31:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:44 INFO - Copying logs to upload dir... 10:31:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1219.996749 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 20 secs) (at 2016-06-23 10:31:44.765633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:31:44.769518) ========= 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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 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/9b72775424cfbd2cdbc3f6dbcfb33ac5fd5f0c140817d1f1049f1c7601aa218181363473c8453e26d20bc00af5aa3756e99733b5b39ec1cbfcca3db78ec838ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b16e353d9653a2ae78fd0c9ab464dd4d69a79283542df9fe855d38a8c26cbe75b5156ddfbab6638c92307762a0d02d89ed9962d08734c701989c0b3f20fde60"} build_url:https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/UrhC7z7BRZu5b2ccvoOXWg/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/9b72775424cfbd2cdbc3f6dbcfb33ac5fd5f0c140817d1f1049f1c7601aa218181363473c8453e26d20bc00af5aa3756e99733b5b39ec1cbfcca3db78ec838ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b16e353d9653a2ae78fd0c9ab464dd4d69a79283542df9fe855d38a8c26cbe75b5156ddfbab6638c92307762a0d02d89ed9962d08734c701989c0b3f20fde60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:31:44.795988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:31:44.796346) ========= 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=1f5564757af27664ca02d71f000001b0-1466701882.284594-900681165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:31:44.879438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:31:44.879796) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:31:44.880135) ========= ========= Total master_lag: 0.19 =========