builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1466702961.38 results: success (0) buildid: 20160623073824 builduid: d39eea867a1c44bca4b8b9a99f11a4a0 revision: 77a913855173eb131614d3ff2325efdece6582a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.383364) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.383907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.384194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.399791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.400173) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 10:29:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.8M=0.001s 2016-06-23 10:29:21 (10.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.286398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.701144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.701458) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:21.751582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:29:21.751940) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 77a913855173eb131614d3ff2325efdece6582a4 --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 77a913855173eb131614d3ff2325efdece6582a4 --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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 10:29:22,078 truncating revision to first 12 chars 2016-06-23 10:29:22,078 Setting DEBUG logging. 2016-06-23 10:29:22,078 attempt 1/10 2016-06-23 10:29:22,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/77a913855173?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 10:29:23,672 unpacking tar archive at: mozilla-beta-77a913855173/testing/mozharness/ program finished with exit code 0 elapsedTime=1.923387 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 10:29:23.689233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:23.689598) ========= script_repo_revision: 77a913855173eb131614d3ff2325efdece6582a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:23.689999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:23.690318) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 10:29:23.699738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-23 10:29:23.700090) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:29:24 INFO - MultiFileLogger online at 20160623 10:29:24 in /builds/slave/test 10:29:24 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:29:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:29:24 INFO - {'append_to_log': False, 10:29:24 INFO - 'base_work_dir': '/builds/slave/test', 10:29:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:29:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:29:24 INFO - 'branch': 'Mozilla-Beta', 10:29:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:29:24 INFO - 'config_files': ('talos/linux_config.py',), 10:29:24 INFO - 'default_actions': ('clobber', 10:29:24 INFO - 'read-buildbot-config', 10:29:24 INFO - 'download-and-extract', 10:29:24 INFO - 'populate-webroot', 10:29:24 INFO - 'create-virtualenv', 10:29:24 INFO - 'install', 10:29:24 INFO - 'run-tests'), 10:29:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:29:24 INFO - 'download_minidump_stackwalk': True, 10:29:24 INFO - 'download_symbols': 'ondemand', 10:29:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:29:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:29:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:29:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:29:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:29:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:29:24 INFO - 'installer_path': 'installer.exe', 10:29:24 INFO - 'log_level': 'info', 10:29:24 INFO - 'log_name': 'talos', 10:29:24 INFO - 'log_to_console': True, 10:29:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:29:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:29:24 INFO - 'opt_config_files': (), 10:29:24 INFO - 'pip_index': False, 10:29:24 INFO - 'sps_profile': False, 10:29:24 INFO - 'sps_profile_interval': 0, 10:29:24 INFO - 'suite': 'dromaeojs-e10s', 10:29:24 INFO - 'system_bits': '32', 10:29:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:29:24 INFO - 'title': 'talos-linux64-ix-022', 10:29:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:29:24 INFO - 'use_talos_json': True, 10:29:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:29:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:29:24 INFO - 'work_dir': 'build'} 10:29:24 INFO - ##### 10:29:24 INFO - ##### Running clobber step. 10:29:24 INFO - ##### 10:29:24 INFO - Running pre-action listener: _resource_record_pre_action 10:29:24 INFO - Running main action method: clobber 10:29:24 INFO - rmtree: /builds/slave/test/build 10:29:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:29:24 INFO - Running post-action listener: _resource_record_post_action 10:29:24 INFO - ##### 10:29:24 INFO - ##### Running read-buildbot-config step. 10:29:24 INFO - ##### 10:29:24 INFO - Running pre-action listener: _resource_record_pre_action 10:29:24 INFO - Running main action method: read_buildbot_config 10:29:24 INFO - Using buildbot properties: 10:29:24 INFO - { 10:29:24 INFO - "project": "", 10:29:24 INFO - "product": "firefox", 10:29:24 INFO - "script_repo_revision": "production", 10:29:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:29:24 INFO - "repository": "", 10:29:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:29:24 INFO - "buildid": "20160623073824", 10:29:24 INFO - "pgo_build": "True", 10:29:24 INFO - "basedir": "/builds/slave/test", 10:29:24 INFO - "buildnumber": 53, 10:29:24 INFO - "slavename": "talos-linux64-ix-022", 10:29:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:29:24 INFO - "platform": "ubuntu64_hw", 10:29:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:29:24 INFO - "branch": "mozilla-beta", 10:29:24 INFO - "repo_path": "releases/mozilla-beta", 10:29:24 INFO - "revision": "77a913855173eb131614d3ff2325efdece6582a4", 10:29:24 INFO - "stage_platform": "linux64-pgo", 10:29:24 INFO - "builduid": "d39eea867a1c44bca4b8b9a99f11a4a0", 10:29:24 INFO - "slavebuilddir": "test" 10:29:24 INFO - } 10:29:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:29:24 INFO - Running post-action listener: _resource_record_post_action 10:29:24 INFO - ##### 10:29:24 INFO - ##### Running download-and-extract step. 10:29:24 INFO - ##### 10:29:24 INFO - Running pre-action listener: _resource_record_pre_action 10:29:24 INFO - Running main action method: download_and_extract 10:29:24 INFO - mkdir: /builds/slave/test/build/tests 10:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:24 INFO - https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:25 INFO - Downloaded 1327 bytes. 10:29:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:29:25 INFO - Using the following test package requirements: 10:29:25 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:29:25 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:29:25 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:29:25 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'jsshell-linux-x86_64.zip'], 10:29:25 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:29:25 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:29:25 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:29:25 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:29:25 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:29:25 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:29:25 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:29:25 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:29: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:29:25 INFO - https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:26 INFO - Downloaded 24185476 bytes. 10:29:26 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:29:26 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:29:28 INFO - Return code: 0 10:29: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:29: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:29:28 INFO - https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:29 INFO - Downloaded 24185476 bytes. 10:29: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:29: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:29:30 INFO - Return code: 0 10:29:30 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:29:30 INFO - https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:32 INFO - Downloaded 10840145 bytes. 10:29: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:29: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:29:32 INFO - Return code: 0 10:29: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:29:32 INFO - https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:29:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:29:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:29:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcxKJmgjSruBB-0hdjGlUw/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:29:33 INFO - Downloaded 56003021 bytes. 10:29:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:29:33 INFO - mkdir: /builds/slave/test/properties 10:29:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:33 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:33 INFO - Contents: 10:29:33 INFO - build_url:https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:29:34 INFO - Running post-action listener: _resource_record_post_action 10:29:34 INFO - Running post-action listener: set_extra_try_arguments 10:29:34 INFO - ##### 10:29:34 INFO - ##### Running populate-webroot step. 10:29:34 INFO - ##### 10:29:34 INFO - Running pre-action listener: _resource_record_pre_action 10:29:34 INFO - Running main action method: populate_webroot 10:29:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:34 INFO - '--tppagecycles', 10:29:34 INFO - '7'], 10:29:34 INFO - 'tests': ['tsvgm']}}, 10:29:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['damp', 'tps']}, 10:29:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'tests': ['damp', 'tps']}, 10:29:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['dromaeo_dom']}, 10:29:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['a11yr', 10:29:34 INFO - 'ts_paint', 10:29:34 INFO - 'tpaint', 10:29:34 INFO - 'sessionrestore', 10:29:34 INFO - 'sessionrestore_no_auto_restore', 10:29:34 INFO - 'tabpaint']}, 10:29:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['tsvgx', 10:29:34 INFO - 'tsvgr_opacity', 10:29:34 INFO - 'tart', 10:29:34 INFO - 'tscrollx', 10:29:34 INFO - 'cart']}, 10:29:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:34 INFO - 'tsvgr_opacity', 10:29:34 INFO - 'tart', 10:29:34 INFO - 'tscrollx', 10:29:34 INFO - 'cart']}, 10:29:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'talos_options': ['--disable-e10s'], 10:29:34 INFO - 'tests': ['tp5o']}, 10:29:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'tests': ['tp5o']}, 10:29:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'talos_options': ['--disable-e10s', 10:29:34 INFO - '--xperf_path', 10:29:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:34 INFO - 'tests': ['tp5n']}, 10:29:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:34 INFO - 'talos_options': ['--xperf_path', 10:29:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:34 INFO - 'tests': ['tp5n']}}, 10:29:34 INFO - 'talos.zip': {'path': '', 10:29:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:34 INFO - Running post-action listener: _resource_record_post_action 10:29:34 INFO - ##### 10:29:34 INFO - ##### Running create-virtualenv step. 10:29:34 INFO - ##### 10:29:34 INFO - Running pre-action listener: _resource_record_pre_action 10:29:34 INFO - Running main action method: create_virtualenv 10:29:34 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29: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:29:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:34 INFO - Using real prefix '/usr' 10:29:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:37 INFO - Installing pip.................done. 10:29:37 INFO - Return code: 0 10:29:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29: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:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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', 'pip>=1.5'] in /builds/slave/test/build 10:29: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 pip>=1.5 10:29:37 INFO - Using env: {'DISPLAY': ':0', 10:29:37 INFO - 'HOME': '/home/cltbld', 10:29:37 INFO - 'LANG': 'en_US.UTF-8', 10:29:37 INFO - 'LANGUAGE': 'en_US:en', 10:29:37 INFO - 'LOGNAME': 'cltbld', 10:29:37 INFO - 'MAIL': '/var/mail/cltbld', 10:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:37 INFO - 'MOZ_NO_REMOTE': '1', 10:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:37 INFO - 'NO_EM_RESTART': '1', 10:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:37 INFO - 'PWD': '/builds/slave/test', 10:29:37 INFO - 'SHELL': '/bin/bash', 10:29:37 INFO - 'SHLVL': '1', 10:29:37 INFO - 'TERM': 'linux', 10:29:37 INFO - 'TMOUT': '86400', 10:29:37 INFO - 'USER': 'cltbld', 10:29:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:37 INFO - '_': '/tools/buildbot/bin/python'} 10:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29: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:29:37 INFO - Cleaning up... 10:29:37 INFO - Return code: 0 10:29:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:29: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:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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:29: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:29:37 INFO - Using env: {'DISPLAY': ':0', 10:29:37 INFO - 'HOME': '/home/cltbld', 10:29:37 INFO - 'LANG': 'en_US.UTF-8', 10:29:37 INFO - 'LANGUAGE': 'en_US:en', 10:29:37 INFO - 'LOGNAME': 'cltbld', 10:29:37 INFO - 'MAIL': '/var/mail/cltbld', 10:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:37 INFO - 'MOZ_NO_REMOTE': '1', 10:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:37 INFO - 'NO_EM_RESTART': '1', 10:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:37 INFO - 'PWD': '/builds/slave/test', 10:29:37 INFO - 'SHELL': '/bin/bash', 10:29:37 INFO - 'SHLVL': '1', 10:29:37 INFO - 'TERM': 'linux', 10:29:37 INFO - 'TMOUT': '86400', 10:29:37 INFO - 'USER': 'cltbld', 10:29:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:37 INFO - '_': '/tools/buildbot/bin/python'} 10:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:37 INFO - Downloading/unpacking psutil>=0.7.1 10:29: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:29: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:29: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:29: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:29: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:29: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:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:29:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:39 INFO - Installing collected packages: psutil 10:29:39 INFO - Running setup.py install for psutil 10:29:39 INFO - building 'psutil._psutil_linux' extension 10:29: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:29: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:29:39 INFO - building 'psutil._psutil_posix' extension 10:29: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:29:40 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:29:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:40 INFO - Successfully installed psutil 10:29:40 INFO - Cleaning up... 10:29:40 INFO - Return code: 0 10:29:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:29:40 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:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:40 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:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:40 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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29:40 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:29:40 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:29:40 INFO - Using env: {'DISPLAY': ':0', 10:29:40 INFO - 'HOME': '/home/cltbld', 10:29:40 INFO - 'LANG': 'en_US.UTF-8', 10:29:40 INFO - 'LANGUAGE': 'en_US:en', 10:29:40 INFO - 'LOGNAME': 'cltbld', 10:29:40 INFO - 'MAIL': '/var/mail/cltbld', 10:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:40 INFO - 'MOZ_NO_REMOTE': '1', 10:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:40 INFO - 'NO_EM_RESTART': '1', 10:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:40 INFO - 'PWD': '/builds/slave/test', 10:29:40 INFO - 'SHELL': '/bin/bash', 10:29:40 INFO - 'SHLVL': '1', 10:29:40 INFO - 'TERM': 'linux', 10:29:40 INFO - 'TMOUT': '86400', 10:29:40 INFO - 'USER': 'cltbld', 10:29:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:40 INFO - '_': '/tools/buildbot/bin/python'} 10:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:29: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:29: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:29: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:29: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:29: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:29: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:29:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29: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:29:42 INFO - Installing collected packages: mozsystemmonitor 10:29:42 INFO - Running setup.py install for mozsystemmonitor 10:29:42 INFO - Successfully installed mozsystemmonitor 10:29:42 INFO - Cleaning up... 10:29:42 INFO - Return code: 0 10:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29: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:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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:29: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:29:42 INFO - Using env: {'DISPLAY': ':0', 10:29:42 INFO - 'HOME': '/home/cltbld', 10:29:42 INFO - 'LANG': 'en_US.UTF-8', 10:29:42 INFO - 'LANGUAGE': 'en_US:en', 10:29:42 INFO - 'LOGNAME': 'cltbld', 10:29:42 INFO - 'MAIL': '/var/mail/cltbld', 10:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:42 INFO - 'MOZ_NO_REMOTE': '1', 10:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:42 INFO - 'NO_EM_RESTART': '1', 10:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:42 INFO - 'PWD': '/builds/slave/test', 10:29:42 INFO - 'SHELL': '/bin/bash', 10:29:42 INFO - 'SHLVL': '1', 10:29:42 INFO - 'TERM': 'linux', 10:29:42 INFO - 'TMOUT': '86400', 10:29:42 INFO - 'USER': 'cltbld', 10:29:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:42 INFO - '_': '/tools/buildbot/bin/python'} 10:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:29: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:29: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:29: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:29: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:29: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:29: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:29:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:45 INFO - Downloading docopt-0.6.1.tar.gz 10:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:45 INFO - Running setup.py install for blobuploader 10:29:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:45 INFO - Running setup.py install for requests 10:29:45 INFO - Running setup.py install for docopt 10:29:45 INFO - Successfully installed blobuploader requests docopt 10:29:45 INFO - Cleaning up... 10:29:45 INFO - Return code: 0 10:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29: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:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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:29: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:29:45 INFO - Using env: {'DISPLAY': ':0', 10:29:45 INFO - 'HOME': '/home/cltbld', 10:29:45 INFO - 'LANG': 'en_US.UTF-8', 10:29:45 INFO - 'LANGUAGE': 'en_US:en', 10:29:45 INFO - 'LOGNAME': 'cltbld', 10:29:45 INFO - 'MAIL': '/var/mail/cltbld', 10:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:45 INFO - 'MOZ_NO_REMOTE': '1', 10:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:45 INFO - 'NO_EM_RESTART': '1', 10:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:45 INFO - 'PWD': '/builds/slave/test', 10:29:45 INFO - 'SHELL': '/bin/bash', 10:29:45 INFO - 'SHLVL': '1', 10:29:45 INFO - 'TERM': 'linux', 10:29:45 INFO - 'TMOUT': '86400', 10:29:45 INFO - 'USER': 'cltbld', 10:29:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:45 INFO - '_': '/tools/buildbot/bin/python'} 10:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:46 INFO - Running setup.py (path:/tmp/pip-3FsqZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:46 INFO - Running setup.py (path:/tmp/pip-_i9cdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:46 INFO - Running setup.py (path:/tmp/pip-fodLYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:46 INFO - Running setup.py (path:/tmp/pip-LmefUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:46 INFO - Running setup.py (path:/tmp/pip-qAy1mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:46 INFO - Running setup.py (path:/tmp/pip-cfr5gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:46 INFO - Running setup.py (path:/tmp/pip-eDwyal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:46 INFO - Running setup.py (path:/tmp/pip-NlYlrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:46 INFO - Running setup.py (path:/tmp/pip-pPA1uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:46 INFO - Running setup.py (path:/tmp/pip-n5bpFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:46 INFO - Running setup.py (path:/tmp/pip-MKWBJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:46 INFO - Running setup.py (path:/tmp/pip-2AL3uE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:46 INFO - Running setup.py (path:/tmp/pip-RDYMy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:47 INFO - Running setup.py (path:/tmp/pip-6hY_6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:47 INFO - Running setup.py (path:/tmp/pip-JUnn8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:47 INFO - Running setup.py (path:/tmp/pip-wpdqzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:47 INFO - Running setup.py (path:/tmp/pip-oLzQIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:47 INFO - Running setup.py install for manifestparser 10:29:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozcrash 10:29:47 INFO - Running setup.py install for mozdebug 10:29:47 INFO - Running setup.py install for mozdevice 10:29:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozfile 10:29:47 INFO - Running setup.py install for mozhttpd 10:29:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:47 INFO - Running setup.py install for mozinfo 10:29:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozInstall 10:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozleak 10:29:48 INFO - Running setup.py install for mozlog 10:29:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for moznetwork 10:29:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozprocess 10:29:48 INFO - Running setup.py install for mozprofile 10:29:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozrunner 10:29:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:48 INFO - Running setup.py install for mozscreenshot 10:29:48 INFO - Running setup.py install for moztest 10:29:49 INFO - Running setup.py install for mozversion 10:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:49 INFO - Cleaning up... 10:29:49 INFO - Return code: 0 10:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:49 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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29:49 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:29:49 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:29:49 INFO - Using env: {'DISPLAY': ':0', 10:29:49 INFO - 'HOME': '/home/cltbld', 10:29:49 INFO - 'LANG': 'en_US.UTF-8', 10:29:49 INFO - 'LANGUAGE': 'en_US:en', 10:29:49 INFO - 'LOGNAME': 'cltbld', 10:29:49 INFO - 'MAIL': '/var/mail/cltbld', 10:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:49 INFO - 'MOZ_NO_REMOTE': '1', 10:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:49 INFO - 'NO_EM_RESTART': '1', 10:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:49 INFO - 'PWD': '/builds/slave/test', 10:29:49 INFO - 'SHELL': '/bin/bash', 10:29:49 INFO - 'SHLVL': '1', 10:29:49 INFO - 'TERM': 'linux', 10:29:49 INFO - 'TMOUT': '86400', 10:29:49 INFO - 'USER': 'cltbld', 10:29:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:49 INFO - '_': '/tools/buildbot/bin/python'} 10:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:49 INFO - Running setup.py (path:/tmp/pip-04izVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:49 INFO - Running setup.py (path:/tmp/pip-h5lV_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:49 INFO - Running setup.py (path:/tmp/pip-tdn31P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:49 INFO - Running setup.py (path:/tmp/pip-7ysYEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:49 INFO - Running setup.py (path:/tmp/pip-vBj0Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:49 INFO - Running setup.py (path:/tmp/pip-R1y80F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:49 INFO - Running setup.py (path:/tmp/pip-5YOc9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:49 INFO - Running setup.py (path:/tmp/pip-kX7c_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:49 INFO - Running setup.py (path:/tmp/pip-vXXIcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29: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:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:49 INFO - Running setup.py (path:/tmp/pip-kaYmVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:50 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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:50 INFO - Running setup.py (path:/tmp/pip-mZqgX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:50 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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:50 INFO - Running setup.py (path:/tmp/pip-QvZ8fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:50 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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:50 INFO - Running setup.py (path:/tmp/pip-2yxZRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29: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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:50 INFO - Running setup.py (path:/tmp/pip-Ahp52p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29: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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:50 INFO - Running setup.py (path:/tmp/pip-ujDF4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29: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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:50 INFO - Running setup.py (path:/tmp/pip-52Mjng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29: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:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:50 INFO - Running setup.py (path:/tmp/pip-wj5M3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29: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:29: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:29: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:29: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:29: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:29: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:29:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:52 INFO - Downloading blessings-1.6.tar.gz 10:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:52 INFO - Installing collected packages: blessings 10:29:52 INFO - Running setup.py install for blessings 10:29:52 INFO - Successfully installed blessings 10:29:52 INFO - Cleaning up... 10:29:52 INFO - Return code: 0 10:29:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:52 INFO - Reading from file tmpfile_stdout 10:29:52 INFO - Current package versions: 10:29:52 INFO - argparse == 1.2.1 10:29:52 INFO - blessings == 1.6 10:29:52 INFO - blobuploader == 1.2.4 10:29:52 INFO - docopt == 0.6.1 10:29:52 INFO - manifestparser == 1.1 10:29:52 INFO - mozInstall == 1.12 10:29:52 INFO - mozcrash == 0.17 10:29:52 INFO - mozdebug == 0.1 10:29:52 INFO - mozdevice == 0.48 10:29:52 INFO - mozfile == 1.2 10:29:52 INFO - mozhttpd == 0.7 10:29:52 INFO - mozinfo == 0.9 10:29:52 INFO - mozleak == 0.1 10:29:52 INFO - mozlog == 3.1 10:29:52 INFO - moznetwork == 0.27 10:29:52 INFO - mozprocess == 0.22 10:29:52 INFO - mozprofile == 0.28 10:29:52 INFO - mozrunner == 6.11 10:29:52 INFO - mozscreenshot == 0.1 10:29:52 INFO - mozsystemmonitor == 0.0 10:29:52 INFO - moztest == 0.7 10:29:52 INFO - mozversion == 1.4 10:29:52 INFO - psutil == 3.1.1 10:29:52 INFO - requests == 1.2.3 10:29:52 INFO - wsgiref == 0.1.2 10:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29: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:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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:29: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:29:52 INFO - Using env: {'DISPLAY': ':0', 10:29:52 INFO - 'HOME': '/home/cltbld', 10:29:52 INFO - 'LANG': 'en_US.UTF-8', 10:29:52 INFO - 'LANGUAGE': 'en_US:en', 10:29:52 INFO - 'LOGNAME': 'cltbld', 10:29:52 INFO - 'MAIL': '/var/mail/cltbld', 10:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:52 INFO - 'MOZ_NO_REMOTE': '1', 10:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:52 INFO - 'NO_EM_RESTART': '1', 10:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:52 INFO - 'PWD': '/builds/slave/test', 10:29:52 INFO - 'SHELL': '/bin/bash', 10:29:52 INFO - 'SHLVL': '1', 10:29:52 INFO - 'TERM': 'linux', 10:29:52 INFO - 'TMOUT': '86400', 10:29:52 INFO - 'USER': 'cltbld', 10:29:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:52 INFO - '_': '/tools/buildbot/bin/python'} 10:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 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:29:53 INFO - Cleaning up... 10:29:53 INFO - Return code: 0 10:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:29:53 INFO - Using env: {'DISPLAY': ':0', 10:29:53 INFO - 'HOME': '/home/cltbld', 10:29:53 INFO - 'LANG': 'en_US.UTF-8', 10:29:53 INFO - 'LANGUAGE': 'en_US:en', 10:29:53 INFO - 'LOGNAME': 'cltbld', 10:29:53 INFO - 'MAIL': '/var/mail/cltbld', 10:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:53 INFO - 'MOZ_NO_REMOTE': '1', 10:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:53 INFO - 'NO_EM_RESTART': '1', 10:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:53 INFO - 'PWD': '/builds/slave/test', 10:29:53 INFO - 'SHELL': '/bin/bash', 10:29:53 INFO - 'SHLVL': '1', 10:29:53 INFO - 'TERM': 'linux', 10:29:53 INFO - 'TMOUT': '86400', 10:29:53 INFO - 'USER': 'cltbld', 10:29:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:53 INFO - '_': '/tools/buildbot/bin/python'} 10:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:53 INFO - Downloading/unpacking jsonschema 10:29: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:29: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:29: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:29: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:29: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:29: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:29:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:55 INFO - Downloading/unpacking functools32 (from jsonschema) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:55 INFO - warning: no files found matching '*.txt' 10:29:55 INFO - no previously-included directories found matching 'build' 10:29:55 INFO - no previously-included directories found matching 'dist' 10:29:55 INFO - no previously-included directories found matching '.git*' 10:29:55 INFO - Installing collected packages: jsonschema, functools32 10:29:55 INFO - Running setup.py install for functools32 10:29:55 INFO - warning: no files found matching '*.txt' 10:29:55 INFO - no previously-included directories found matching 'build' 10:29:55 INFO - no previously-included directories found matching 'dist' 10:29:55 INFO - no previously-included directories found matching '.git*' 10:29:55 INFO - Successfully installed jsonschema functools32 10:29:55 INFO - Cleaning up... 10:29:55 INFO - Return code: 0 10:29:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:29: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:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29: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 0x7ff83d1b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', '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:29: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:29: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:29:55 INFO - Using env: {'DISPLAY': ':0', 10:29:55 INFO - 'HOME': '/home/cltbld', 10:29:55 INFO - 'LANG': 'en_US.UTF-8', 10:29:55 INFO - 'LANGUAGE': 'en_US:en', 10:29:55 INFO - 'LOGNAME': 'cltbld', 10:29:55 INFO - 'MAIL': '/var/mail/cltbld', 10:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:55 INFO - 'MOZ_NO_REMOTE': '1', 10:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:55 INFO - 'NO_EM_RESTART': '1', 10:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:55 INFO - 'PWD': '/builds/slave/test', 10:29:55 INFO - 'SHELL': '/bin/bash', 10:29:55 INFO - 'SHLVL': '1', 10:29:55 INFO - 'TERM': 'linux', 10:29:55 INFO - 'TMOUT': '86400', 10:29:55 INFO - 'USER': 'cltbld', 10:29:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:55 INFO - '_': '/tools/buildbot/bin/python'} 10:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:55 INFO - Downloading/unpacking flake8 10:29: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:29: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:29: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:29: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:29: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:29: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:29:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:29:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:29:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:29: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:29: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:29: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:29: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:29: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:29: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:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:58 INFO - no previously-included directories found matching 'docs/_build' 10:29:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:29:58 INFO - Running setup.py install for pep8 10:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:58 INFO - no previously-included directories found matching 'docs/_build' 10:29:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:29:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:29:58 INFO - Cleaning up... 10:29:58 INFO - Return code: 0 10:29:58 INFO - Running post-action listener: _resource_record_post_action 10:29:58 INFO - Running post-action listener: _start_resource_monitoring 10:29:58 INFO - Starting resource monitoring. 10:29:58 INFO - ##### 10:29:58 INFO - ##### Running install step. 10:29:58 INFO - ##### 10:29:58 INFO - Running pre-action listener: _resource_record_pre_action 10:29:58 INFO - Running main action method: install 10:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:59 INFO - Reading from file tmpfile_stdout 10:29:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:59 INFO - Reading from file tmpfile_stdout 10:29:59 INFO - Output received: 10:29:59 INFO - Usage: mozinstall [options] installer 10:29:59 INFO - Options: 10:29:59 INFO - -h, --help show this help message and exit 10:29:59 INFO - -d DEST, --destination=DEST 10:29:59 INFO - Directory to install application into. [default: 10:29:59 INFO - "/builds/slave/test"] 10:29:59 INFO - --app=APP Application being installed. [default: firefox] 10:29:59 INFO - mkdir: /builds/slave/test/build/application 10:29:59 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:29:59 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:30:12 INFO - Reading from file tmpfile_stdout 10:30:12 INFO - Output received: 10:30:12 INFO - /builds/slave/test/build/application/firefox/firefox 10:30:12 INFO - Running post-action listener: _resource_record_post_action 10:30:12 INFO - ##### 10:30:12 INFO - ##### Running run-tests step. 10:30:12 INFO - ##### 10:30:12 INFO - Running pre-action listener: _resource_record_pre_action 10:30:12 INFO - Running main action method: run_tests 10:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:12 INFO - Python 2.7.3 10:30:12 INFO - Return code: 0 10:30:12 INFO - grabbing minidump binary from tooltool 10:30: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:30: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 0x2cbe410>, '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 0x2cbf310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbf7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30: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:30: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:30:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:12 INFO - Return code: 0 10:30:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:30:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:30:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:30:13 INFO - Return code: 0 10:30: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/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:30: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/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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:30:13 INFO - Using env: {'DISPLAY': ':0', 10:30:13 INFO - 'HOME': '/home/cltbld', 10:30:13 INFO - 'LANG': 'en_US.UTF-8', 10:30:13 INFO - 'LANGUAGE': 'en_US:en', 10:30:13 INFO - 'LOGNAME': 'cltbld', 10:30:13 INFO - 'MAIL': '/var/mail/cltbld', 10:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:13 INFO - 'MOZ_NO_REMOTE': '1', 10:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:13 INFO - 'NO_EM_RESTART': '1', 10:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:13 INFO - 'PWD': '/builds/slave/test', 10:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:13 INFO - 'SHELL': '/bin/bash', 10:30:13 INFO - 'SHLVL': '1', 10:30:13 INFO - 'TERM': 'linux', 10:30:13 INFO - 'TMOUT': '86400', 10:30:13 INFO - 'USER': 'cltbld', 10:30:13 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351', 10:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:13 INFO - '_': '/tools/buildbot/bin/python'} 10:30: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/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:30:13 INFO - mozversion application_buildid: 20160623073824 10:30:13 INFO - mozversion application_changeset: 77a913855173eb131614d3ff2325efdece6582a4 10:30:13 INFO - mozversion application_display_name: Firefox 10:30:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:13 INFO - mozversion application_name: Firefox 10:30:13 INFO - mozversion application_remotingname: firefox 10:30:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:30:13 INFO - mozversion application_vendor: Mozilla 10:30:13 INFO - mozversion application_version: 48.0 10:30:13 INFO - mozversion platform_buildid: 20160623073824 10:30:13 INFO - mozversion platform_changeset: 77a913855173eb131614d3ff2325efdece6582a4 10:30:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:30:13 INFO - mozversion platform_version: 48.0 10:30:13 INFO - using testdate: 1466703013 10:30:13 INFO - actual date: 1466703013 10:30:13 INFO - starting webserver on 'localhost:46866' 10:30:13 INFO - SUITE-START | Running 2 tests 10:30:13 INFO - TEST-START | dromaeo_css 10:30:13 INFO - operating with platform_type : linux_ 10:30:13 INFO - Initialising browser for dromaeo_css test... 10:30:13 INFO - TEST-INFO | started process 23203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxROPa/profile http://localhost:46866/getInfo.html) 10:30:17 INFO - PROCESS | 23203 | 10:30:17 INFO - PROCESS | 23203 | (process:23282): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:18 INFO - PROCESS | 23203 | __metrics Screen width/height:1600/1200 10:30:18 INFO - PROCESS | 23203 | colorDepth:24 10:30:18 INFO - PROCESS | 23203 | Browser inner width/height: 1024/697 10:30:18 INFO - PROCESS | 23203 | __metrics 10:30:18 ERROR - PROCESS | 23203 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:30:19 INFO - TEST-INFO | 23203: exit 0 10:30:19 INFO - Browser initialized. 10:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:19 INFO - TEST-INFO | started process 23332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjxROPa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:21 INFO - PROCESS | 23332 | 10:30:21 INFO - PROCESS | 23332 | (process:23400): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:30:31 INFO - PROCESS | 23332 | RSS: Main: 151105536 10:30:31 INFO - PROCESS | 23332 | 10:31:21 INFO - PROCESS | 23332 | 1466703081128 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:33:28 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46866/tests/dromaeo/cssquery-ext.html) 10:33:29 INFO - PROCESS | 23332 | RSS: Main: 154959872 10:33:29 INFO - PROCESS | 23332 | 10:36:31 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-ext.html (next: http://localhost:46866/tests/dromaeo/cssquery-jquery.html) 10:36:32 INFO - PROCESS | 23332 | RSS: Main: 152973312 10:36:32 INFO - PROCESS | 23332 | 10:39:33 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46866/tests/dromaeo/cssquery-mootools.html) 10:39:34 INFO - PROCESS | 23332 | RSS: Main: 153260032 10:39:34 INFO - PROCESS | 23332 | 10:42:35 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46866/tests/dromaeo/cssquery-prototype.html) 10:42:36 INFO - PROCESS | 23332 | RSS: Main: 153640960 10:42:36 INFO - PROCESS | 23332 | 10:45:38 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46866/tests/dromaeo/cssquery-yui.html) 10:45:39 INFO - PROCESS | 23332 | RSS: Main: 152551424 10:45:39 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | Cycle 1(1): loaded http://localhost:46866/tests/dromaeo/cssquery-yui.html (next: http://localhost:46866/tests/dromaeo/cssquery-dojo.html) 10:48:41 INFO - PROCESS | 23332 | RSS: Main: 156536832 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | __start_tp_report 10:48:41 INFO - PROCESS | 23332 | _x_x_mozilla_page_load 10:48:41 INFO - PROCESS | 23332 | _x_x_mozilla_page_load_details 10:48:41 INFO - PROCESS | 23332 | |i|pagename|runs| 10:48:41 INFO - PROCESS | 23332 | |0;dojo.html;3321.6014078310604;3360.6807353301438;3396.592408910931;3402.098443912362;3404.7957122572648;5642.830715078544;5693.9715301423485;5697.601167918237;5703.885922281552;5736.996025695502;5683.488486036256;5707.828765137053;5714.200011998313;5718.485336319731;5770.624909380897;5131.153359695655;5145.86790906002;5194.584433245332;5195.428502864682;5218.947810521884;5149.768260428271;5261.789528418859;5278.392984806739;5289.841304760864;5300.787968481256;5123.2827404163445;5131.153359695664;5171.146760784485;5195.896082078356;5319.6808191508635;5182.274481572564;5197.272381866523;5199.740012999373;5200.661956972823;5205.141151709963;5077.416097148801;5085.516875896821;5167.069927413064;5172.456892026321;5209.6874187548865;5577.749001294951;5591.580631452657;5667;5667.461591148875;5704.172894930211;6119.571629985903;6136.447719705248;6141.140240366352;6149.2620885494025;6157.815265541996;6092.299385570627;6188.628682279078;6201.534884883652;6202.038684003986;6207.34822843604;5701.486866182064;5717.485426311652;5751.166080918285;5752.165935939307;5782.739776710058;6292.716827742763;6315.96842015787;6319.842003949938;6322.462590679844;6325.114483972247;6045.486133678686;6064.636121832704;6067.423594758491;6068.180795592539;6110.5587591967305;6120.081455037911;6120.872274143302;6144.8771024579255;6148.754049838046;6159.322474527888;6081.847953801191;6083.482903953125;6083.756649733961;6095.908561371494;6112.113743507167;6006.639601623917;6067.423594758491;6103.816885493442;6110.358412366726;6120.387961203933;4646.83736069236;4647.512011238839;4649.395578574764;4654.138984287918;4683.929741053887;4162.146759914211;4169.291220492523;4173.8956526087095;4203.138356636882;4227.725197862191;5870.14882841994;5900.852478687982;5928.703564821828;5947.702614869326;5966.433188847052;6136.355682653347;6156.199694039746;6182.1345011698395;6193.535484838655;6262.436380725757;5857.26784151981;5889.146073819272;5942;5946.256717910262;5958.612690175211;5178.6374953752875;5294;5339.81310654133;5354.544863686552;5366.838994830083;6368.617882927039;6373.5857169283845;6378.936210637834;6383.36166383358;6384.074309225136;6088.6042407243385;6135.07973803933;6138.202033735586;6144.139820425144;6146.815595532141;6379.808605741835;6481.935180648133;6487.091807147098;6490;6497;6029.276486821609;6041;6078.665673388006;6079.3008803988105;6085.361037091218;6067;6128.900367973304;6193.009118541012;6196.721147548461;6201.441870231701;6001.279846418458;6046.939530604814;6055.697215139314;6059.091136329585;6093.695315234309;5996.610220335664;6043.516518678407;6047.334793172659;6048.818535443944;6052.939470605237;5794.449527294901;5802.564807639359;5853.707314634336;5960.791372301948;5967.015442451947;5986.281646202484;6023.608465449732;6038.51691864641;6042.5770196087615;6075.544334175043;5888.646681199141;5907.586468947133;5912.408759124053;5913.881722365614;5918.881622367615 10:48:41 INFO - PROCESS | 23332 | |1;ext.html;668.1647940074906;678.4640134293908;682.4063065133334;687.4431710314644;734.4161391693607;32359;33177.50233746496;39692;39817.80091099541;40339.59660403395;42407.78796106015;43019.56980430195;43054.78472607632;43113.35329970045;43153.35269970953;8856.424332418404;8967.327450441211;8990.460572365679;9017.053209413016;9027.819443611124;8724.563771811385;8854.158854908774;8861.778455538599;8884.244839188677;8894.066123057082;8803.251723603502;9168.587413566405;9172.633094676205;9181.40320879144;9195.540222988857;9072.682456114037;9084.046175151612;9104.726858194199;9109.68116115936;9145.039770824034;8901.332400070021;8996.415233009833;9034.14175653312;9041.095890410972;9044.819103617956;43145.35281970773;43519.129617407794;43520.564794351965;43554.564454355364;43635.78182109101;3769.4534292527705;4066.085130845566;4240.024794297298;4250.4899412070445;4445.333200019991;33710.32579348399;33962.1509462263;34087.14782130442;34274.14314642154;34534;4432.667549933768;4489.124620698965;4521.547845215485;4545.318202269686;4563.817447302137;323497;326211.36894315615;326860;328373;329177;61891.381086188565;62210.688946554976;62213;62250;62565.37434625687;69433.30566694369;70116.29883701098;70772;70803;70837;18617.627647447247;18849.623007539773;18862.339818106302;18886.81113188878;18927.716084258747;14057.578272651837;14076.507322243673;14078.648033799032;14099;14107;20636.17455301771;21230;21298.25456109029;21367.8931605341;21374;7742.303192712683;7787.649555769891;7959.005124359455;8005.119436861941;8041.6381262843315;1124.1905827803969;1139.5897476908306;1149.9937554639691;1187.382561068257;1240.6464157715188;32652.346953060805;32691;32955.50566741501;33124.58520666049;33184.502232466046;1199.0946835139414;1231.719773786086;1237.5421094195206;1266.202292555684;1289.9548515801903;17116.400925967533;17230.569235769206;17360.39238626642;17414.47756567305;17602.94382337064;429407;509403;512562;519068;519505;62926.37073629296;63356.683216583624;63642.36357636364;63990.36009639844;64086.679566601866;1481.8060507080506;1540.784290199373;1556.2141118734967;1571.8663913567245;1578.928948197334;32766;33665.326693465504;33679.83160084184;33980;34401.96794096181;53365.19952200643;53872.73063634813;54036.459635403146;54157;54220.18669720036;439112;439203;439866;440790;440998;30950.690493094782;31710.36579268448;31759.52360714545;31776.364472709953;32033.67966320307;49550;50337.49662503328;50608.493915060375;50754;51975.480245198574;41498.79250603728;41996.580034199265;42760.572394276904;43167.13665726731;43487.347689784045;41083;42102.84527269287;42454.78772606117;42803.571964281204;43035.3544696836;35959.28081438409;43031.13937721291;43243;43339.78330108329;43582.56417435785;32982.50526242156;34209;34209.31581368409;34247;34339.4849077269;26912.32719182036;27391.315217119733;28471.715282846908;29020.56469152922;29073.273168170967 10:48:41 INFO - PROCESS | 23332 | |2;jquery.html;441.51653938936863;446.667857780954;447.6776720761055;453.5034137619306;454.97270163790176;18570.814291857096;19179.32872349468;19289;21018.159273629073;21047.47381315468;20054.398368048944;20414.183432662714;20525.178992840305;20583;20645;5443.319585051859;5893.351731309574;5902.2622172228475;5910.704464776765;5916;5741.540676745851;5833.066709326508;5839.970800146015;5840.328362238354;5842.152887831262;5614.2701448811595;5768.971155144219;5780.335261444946;5781.306243250816;5801.129830525434;5730.885382292352;5798.217240672498;5814.883702325951;5818.941810581925;5820.708964551798;5094.235864620299;5244.685318880879;5264.7367631618645;5301.125314323171;5305.628605997582;23173.420664483354;23300.65049024249;23655.645165322534;23851.045958161652;23891;2502.099244272061;2573.1251374532562;2618.7250338714352;2682.1417146512927;2984.5373967035143;14641.70716585673;14980.325885335076;15263.618409539738;15415.15216663083;15472.071675699493;1943.815337542931;1982.544014876572;2069;2071.2129390831537;2126.2345555599973;73785.6310718443;75244;77168.61415692941;78936;79004.60497697475;10659.307145035547;10673;11138.33170009802;11147.386893720923;11551.595694150665;15523.379064837505;15526.922365388327;15631.68736625261;15642.45251416195;15683.451079212173;7920.762377128695;8282;8310.626021828912;8566.229039386486;8614.310855131574;8297.170282971654;8302.335813134934;8304.875426868603;8344.374171937128;8379.455335403301;5082.186850103965;5094.872628184325;5125.666831656005;5166.3025491558155;5243.475652434726;1980.8705641435515;2034.4506983114773;2139.1443422631073;2148.5917675641576;2155.967660485094;1003.4481035430484;1086.380762965118;1109.57836022311;1157.9942100289445;1172.94135293235;16757.58106047334;19232.61534769297;19530.414087577396;19811.405657830288;19908;1050.9527071281657;1102.1843835561788;1102.3165637304921;1117.4189421500937;1123.9775204495863;9663.710088697351;11166.944165279285;11191.608293709682;11193.66419007431;11277;483708;490352;507100;532067;536590;52155;54081;79351.60324198342;83048.58475707583;89419;1191.303087693709;1218.5795900414344;1225.66906935127;1231.2181764579557;1234.950601975929;17992.37026704059;18005.72991405156;18055.729164062286;18072.819271807115;18459;35199.94400167999;38203.23593528169;39295.80352098221;39895.80052099837;40337.59662403339;51785;53819.46180538145;54086.45913540814;54377;54531.18203227034;8704.477731336141;8944.910550894669;9076.863847042432;9099.863502047343;9333.439993600407;10029.398236105857;13161.802572961222;13268.933655332048;13454;13487.460501580219;11496;11583.942080289882;11720.355380454157;11761.235519691192;12244.265344079384;11274.718132046764;11539.8269025963;11690.941545292219;11726.237794543327;11840.881591184323;11337.149713771336;11838.28970261787;11856.407179641155;11923.880761192277;12156.939215303866;8845.955770221108;8961.148690874357;9053.547322633975;9076.455412675261;9090.636374544943;11413.315201087962;11917.702057448287;11938.940305298418;11956.820647690465;12102.334371609646 10:48:41 INFO - PROCESS | 23332 | |3;mootools.html;1614.6124930016797;1625.2686291168977;1823.772028496438;1940.5051711813476;1948.3959972408563;7701.691932322715;8280.83438331233;8396.790080247989;8592.398532102747;8603.225709686134;8047.758567242978;8143.144969778177;8214.342852571795;8244.54654993975;8259.669613215465;2369.0642196332437;2384.3681424422543;2385.7137143542714;2387.6537902004284;2398.8440751351104;2298.793108620224;2313.086330899294;2336.906523739048;2341.8243631727605;2343.5547246023284;2419.129113519132;2426.454047839231;2438.67077944477;2457.299669594166;2460.753924607543;2378.9643155352683;2394.413368724665;2411.071737381112;2415.3720032791425;2473.2332976777257;2394.856308621488;2424.515096980611;2430.647556104355;2432.9391765205833;2436.7441418650965;8786.60460279289;8823.955880220621;8834.911650883538;8837.60230789616;8839.513826739527;5387.084195686703;5519.089350257203;5534.916976245359;5544.112941929272;5544.556435485151;3401.6088149862835;3463.0649724574223;3474.4267195912644;3498.8775392861126;3524.101354154674;1076.5424694504804;1109.290054365207;1131.2251107991053;1167.7372591167004;1170.1808733886314;12174.756504869942;12227.449764760608;12228.694282642917;12235.32705701186;12331.568395106127;4605.240135377692;4615.9076818463445;4626.629869610423;4696.60078893291;4706.458757242961;10477.52851121686;10515.158787296998;10519.894801052045;10537;10545.630902918361;5398.325209348832;5435.103207970719;5439.075357189287;5444.646098003696;5451.427600102012;4839.177339852234;4998.625103117281;5039.496050395004;5061.139606266944;5067.974660126676;3973.5827738087664;3994.08136128692;4068.2677118119022;4086.4483294755423;4112.547619761824;1145.8911403416662;1294.3140135728079;1296.9092163548462;1298.0848501806204;1304.6933970517111;1104.1292639138337;1117.5920788911988;1119.764849381639;1122.4892673833385;1130.2540323386525;6114.419130182626;6141.324454310023;6178.567500274938;6181.660008699475;6208.565400421927;479.79608666316676;482.07441711913214;488.6603810351771;499.02938784064645;1112.5605385872698;4309.07354918694;4333.609975102256;4363.170997510463;4370.562943705668;4375.934360984587;10120.949395252977;10178.541965611417;10451.111655509214;10475;10524.842127368096;10153.746156346151;10182.032706892833;10250.53872575721;10284.228682848816;10312.123469505175;7895.249951254622;7967.322777563856;8053.315468185153;8147.103818579952;8165.795855103551;6121.540884433774;6180.412860778219;6188.628682279078;6189.226346706661;6207.068939659087;9307.534623268944;9470.763230919007;9526.714198574055;9567.521623918916;9638.277129215478;9228.123328283802;9517.238620910171;9718.70843874685;9911.256655750703;9926.503674816086;6839;7472.103347598323;7673.731419400294;7676.808079797826;7788.805279867822;8181.222783835526;8195.67217311301;8212.630431630472;8216.712415065684;8269.29710974574;7150.928490715026;7454.589997550187;7492.587907665131;7555.73554925575;7606.163322034461;7307.378872795872;7343.192248852515;7400.851982960418;7431.888521672287;7493.138289096823;7085.716571337089;7165.0327205828635;7267.854642907007;7300.342969132804;7313.012743279589;5361.946380536301;5448.673079615236;5485.561155107662;5588.077967135378;5601.887962240814;5365.624406291522;5366.919496207638;5392.921415716951;5470.671759694431;5477.507024367826 10:48:41 INFO - PROCESS | 23332 | |4;prototype.html;360.2273124148701;369.97410181287313;370.6682519145365;375.198950241235;379.8784388995519;6407.359264073591;6441.130447389601;6538.803835884931;6545.116409284745;6564.540482166244;6519.380658837403;6548.607083574989;6554.967225163879;6565.737370505174;6566.671666416684;4949.876253093684;4950.059488697145;4962.528559786814;4964.354633897588;4969.925451118236;4974.8258810941625;4974.875628109308;4975.054739599483;4977.3529441172595;4988.226824842137;4934.40787105546;4946.802127914879;4948.604111671058;4954.108260513106;4960;4700.576948074656;4828.661993660445;4947.480514545975;4951.752412379366;4951.826686065989;4234.745915245096;4248.745075295461;4266;4285.142971405731;4286.571342865688;6154.661493617849;6230.314665386803;6243.594166379171;6256.311805701369;6265.404786545271;5709.828705138811;5711.05767548354;5712.914306285409;5727.341355744101;5737.684427356494;6802.863942721118;6836.965815170893;6859.31406859315;6864.322914063519;6883.139607549057;4593.150267200579;4706.647001474903;4771.8091276348905;4776.331313616097;4777.044591081798;7131.001659767637;7133.678984445713;7143.857122857514;7191.885257785052;7196.46026548011;4857.077155340474;4857.1742803723455;4858.611311095104;4858.854234372974;4870.683405578626;4911.557959783637;4916.115099282092;4916.754162291871;4931.235658472942;4937.23472861707;5684.516816070681;5697.857553561112;5706.28671416073;5709.429057094258;5715.342735585377;6794.694238759268;6876.896846547305;6886.896696549556;6906.930930690729;6918.688659010357;1675.8240384759424;1685.5954570902895;1696.550414140254;1699.405208177128;1700.6938751024686;1109.7225693576606;1127.0532752487786;1127.2222166704948;1131.7623299107115;1145.0210070389862;6704.497162712816;6711.832204194837;6716.664166791641;6733.393994540417;6735.696893639798;7105.786826395217;7106.076210092759;7121.537100088478;7125.96437017822;7140.964295178491;6674.9666251669405;6722.563033402813;6727.495437842083;6727.596344219362;6729.1252137221845;3807.371783655721;3851.4030325299623;3852.4028775539837;3853.7495062820826;3859.0352411897024;7313.2321106284135;7569.697212111564;7590.316871481593;7616.619169041525;7629.389648828081;7304.853902921912;7312.305330993547;7313.707451701979;7323.12122545298;7327.74352897646;7530.962345188349;7542.924570754332;7554.093508778982;7559.584222867685;7577.014988051518;6911.861762764817;7208.819779505554;7213.567185968649;7223.855522889407;7230;6959.269276726073;7017.05269788572;7019.613921234177;7024.683889225099;7056.7530136444975;7544.321011109027;7547.622618869144;7549.433792465477;7551.471397002377;7567.356774673995;4875.219964805614;4888.0468308679465;4907.582855457326;4917.213245880642;4924.9507504924495;7053.647317634201;7146.785596432115;7164.785056448315;7191.748288809867;7195.856082878208;6941.305869413019;6944.375006249462;6953.130858642669;6953.895691564731;6978.860422791414;6868.484863635147;6870.828229294108;6939.757108501179;6941.444684425335;6951.200611929693;6822.351876571718;6827.52207345481;6855.520113592001;6896.310368963063;6899.172099347909;6823.317668233335;6978.930210698031;6981.616011119438;6983.615901125284;6988.301169883174;6616.867662646817;6836.93163068363;6844.691988860413;6845.520813543004;6870.656467176721 10:48:41 INFO - PROCESS | 23332 | |5;yui.html;876.6274333408301;891.1355984694852;903.5617725403179;937.2455173585261;951.1914872358496;14813.18527480988;15020.549383518499;15054.096754194756;15072.47246346378;15089.698206035873;14297.714045719105;14719.337629806658;14882.404703811862;14885.032472889254;14927.701445971074;932.7201839448138;941.2517048946104;952.6570434643522;956.7799406136593;957.2389949989774;953.7377221264173;955.3885513271512;966.352543795655;967.1875624475439;968.8982656821038;1003.989960100397;1004.2719028704167;1006.7986402719449;1008.2035192198191;1010.8129995950736;1000.9149222316112;1001.6344034427418;1001.9248556358266;1005.3666190300064;1007.0382784440878;740.0786021403387;740.256042677106;741.2402287655143;741.5773009384653;743.2901578992049;15221.391144354213;15268.694626107415;15298.847011529964;15310.923445382814;15335.463258786;14577.562673119717;14640.560783176521;14674.853251467455;14675.412983480648;14692.26538673062;11583.6524904253;11711.414429278502;11715;11861.110416718695;11938.283702977762;3773.8301776419853;3809.257194847006;3834.3864981603087;3844;3846.4230365445405;54617.1807422885;54618.180727289124;55365.44634553643;55435;55785;11455.885441145481;11659;11704;11752.412379380996;11919.821202681967;20583.07376168076;20914.268000619904;20963;20995.47511312199;21058.78941210599;7611.2769286917655;7989.480683755537;8048.114707382183;8085.474444161111;8340.62467188978;5075.822346217865;5078.238264260391;5095.515925987025;5106.131957567148;5144.562712169508;3641.453781932731;3694.9815250923575;3714.4799728038097;3732.402815549499;3736.7010639148803;634.0869148426251;647.0391468669022;649.4285029174297;656.6880731652427;672.8149758816267;758.1130077808976;787.8345547434989;791.4262159934117;791.5962858941866;810.1695761844157;9707.951460242653;9919.355241909252;9984.15134713543;10048.29661923673;10137.949310253402;652.954293199481;684.387473211473;684.7192651013061;727.3817255333031;788.8225149341353;4455.26488129455;4524.9547504524535;4529.433820772403;4550.772461376918;4596;62583.6870815643;62866;63077;63278.683606581675;63561;52391.21413178805;54637.45362546323;55441.72279138659;55680;55870;45050.32424513635;46363.99999999932;49711.50288497141;51414.22878656823;51618.741906290226;9358.766030849283;9369.203617692572;9486.95256523713;9586.90413095888;9589.232861371212;33651.326973460884;33671.663283366855;35698.46452303269;36829.815850920575;37531;44094.77952610217;44179;45331.09337813159;45757.31364029476;46350.76824615855;12706;12723.346935541205;12799.552015679406;12853.807192892302;12988.220706757626;13101.803472948104;13144;14208.360623771749;14614.488492902698;14639.341229644904;13438.529651462151;13547.661308467366;13753.312334383441;13997.860021399656;14223.217723025333;13214.405351759002;13272.315785792529;13283.070185086952;13308.93345533266;13335.799963000756;13797.379117939516;13841.446342146604;13878.72242555123;13895.444182232597;13917.304134793423;11424.200305978502;11509.194356394972;11645.184837061324;11693.064554835762;11818.349990750246;11415.771684566429;11608.825867611824;11614.88791118761;11722.41387930583;11919.523219071487 10:48:41 INFO - PROCESS | 23332 | __end_tp_report 10:48:41 INFO - PROCESS | 23332 | __start_cc_report 10:48:41 INFO - PROCESS | 23332 | _x_x_mozilla_cycle_collect,322 10:48:41 INFO - PROCESS | 23332 | __end_cc_report 10:48:41 INFO - PROCESS | 23332 | __startTimestamp1466704121678__endTimestamp 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | ------- Summary: start ------- 10:48:41 INFO - PROCESS | 23332 | Number of tests: 6 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#0] dojo.html Cycles:165 Average:5710.07 Median:5960.79 stddev:654.11 (11.0%) stddev-sans-first:628.71 10:48:41 INFO - PROCESS | 23332 | Values: 3321.6 3360.7 3396.6 3402.1 3404.8 5642.8 5694.0 5697.6 5703.9 5737.0 5683.5 5707.8 5714.2 5718.5 5770.6 5131.2 5145.9 5194.6 5195.4 5218.9 5149.8 5261.8 5278.4 5289.8 5300.8 5123.3 5131.2 5171.1 5195.9 5319.7 5182.3 5197.3 5199.7 5200.7 5205.1 5077.4 5085.5 5167.1 5172.5 5209.7 5577.7 5591.6 5667.0 5667.5 5704.2 6119.6 6136.4 6141.1 6149.3 6157.8 6092.3 6188.6 6201.5 6202.0 6207.3 5701.5 5717.5 5751.2 5752.2 5782.7 6292.7 6316.0 6319.8 6322.5 6325.1 6045.5 6064.6 6067.4 6068.2 6110.6 6120.1 6120.9 6144.9 6148.8 6159.3 6081.8 6083.5 6083.8 6095.9 6112.1 6006.6 6067.4 6103.8 6110.4 6120.4 4646.8 4647.5 4649.4 4654.1 4683.9 4162.1 4169.3 4173.9 4203.1 4227.7 5870.1 5900.9 5928.7 5947.7 5966.4 6136.4 6156.2 6182.1 6193.5 6262.4 5857.3 5889.1 5942.0 5946.3 5958.6 5178.6 5294.0 5339.8 5354.5 5366.8 6368.6 6373.6 6378.9 6383.4 6384.1 6088.6 6135.1 6138.2 6144.1 6146.8 6379.8 6481.9 6487.1 6490.0 6497.0 6029.3 6041.0 6078.7 6079.3 6085.4 6067.0 6128.9 6193.0 6196.7 6201.4 6001.3 6046.9 6055.7 6059.1 6093.7 5996.6 6043.5 6047.3 6048.8 6052.9 5794.4 5802.6 5853.7 5960.8 5967.0 5986.3 6023.6 6038.5 6042.6 6075.5 5888.6 5907.6 5912.4 5913.9 5918.9 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#1] ext.html Cycles:180 Average:59668.05 Median:43033.25 stddev:113157.69 (263.0%) stddev-sans-first:113388.42 10:48:41 INFO - PROCESS | 23332 | Values: 668.2 678.5 682.4 687.4 734.4 32359.0 33177.5 39692.0 39817.8 40339.6 42407.8 43019.6 43054.8 43113.4 43153.4 8856.4 8967.3 8990.5 9017.1 9027.8 8724.6 8854.2 8861.8 8884.2 8894.1 8803.3 9168.6 9172.6 9181.4 9195.5 9072.7 9084.0 9104.7 9109.7 9145.0 8901.3 8996.4 9034.1 9041.1 9044.8 43145.4 43519.1 43520.6 43554.6 43635.8 3769.5 4066.1 4240.0 4250.5 4445.3 33710.3 33962.2 34087.1 34274.1 34534.0 4432.7 4489.1 4521.5 4545.3 4563.8 323497.0 326211.4 326860.0 328373.0 329177.0 61891.4 62210.7 62213.0 62250.0 62565.4 69433.3 70116.3 70772.0 70803.0 70837.0 18617.6 18849.6 18862.3 18886.8 18927.7 14057.6 14076.5 14078.6 14099.0 14107.0 20636.2 21230.0 21298.3 21367.9 21374.0 7742.3 7787.6 7959.0 8005.1 8041.6 1124.2 1139.6 1150.0 1187.4 1240.6 32652.3 32691.0 32955.5 33124.6 33184.5 1199.1 1231.7 1237.5 1266.2 1290.0 17116.4 17230.6 17360.4 17414.5 17602.9 429407.0 509403.0 512562.0 519068.0 519505.0 62926.4 63356.7 63642.4 63990.4 64086.7 1481.8 1540.8 1556.2 1571.9 1578.9 32766.0 33665.3 33679.8 33980.0 34402.0 53365.2 53872.7 54036.5 54157.0 54220.2 439112.0 439203.0 439866.0 440790.0 440998.0 30950.7 31710.4 31759.5 31776.4 32033.7 49550.0 50337.5 50608.5 50754.0 51975.5 41498.8 41996.6 42760.6 43167.1 43487.3 41083.0 42102.8 42454.8 42803.6 43035.4 35959.3 43031.1 43243.0 43339.8 43582.6 32982.5 34209.0 34209.3 34247.0 34339.5 26912.3 27391.3 28471.7 29020.6 29073.3 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#2] jquery.html Cycles:180 Average:28974.68 Median:23478.15 stddev:83557.25 (355.9%) stddev-sans-first:83764.18 10:48:41 INFO - PROCESS | 23332 | Values: 441.5 446.7 447.7 453.5 455.0 18570.8 19179.3 19289.0 21018.2 21047.5 20054.4 20414.2 20525.2 20583.0 20645.0 5443.3 5893.4 5902.3 5910.7 5916.0 5741.5 5833.1 5840.0 5840.3 5842.2 5614.3 5769.0 5780.3 5781.3 5801.1 5730.9 5798.2 5814.9 5818.9 5820.7 5094.2 5244.7 5264.7 5301.1 5305.6 23173.4 23300.7 23655.6 23851.0 23891.0 2502.1 2573.1 2618.7 2682.1 2984.5 14641.7 14980.3 15263.6 15415.2 15472.1 1943.8 1982.5 2069.0 2071.2 2126.2 73785.6 75244.0 77168.6 78936.0 79004.6 10659.3 10673.0 11138.3 11147.4 11551.6 15523.4 15526.9 15631.7 15642.5 15683.5 7920.8 8282.0 8310.6 8566.2 8614.3 8297.2 8302.3 8304.9 8344.4 8379.5 5082.2 5094.9 5125.7 5166.3 5243.5 1980.9 2034.5 2139.1 2148.6 2156.0 1003.4 1086.4 1109.6 1158.0 1172.9 16757.6 19232.6 19530.4 19811.4 19908.0 1051.0 1102.2 1102.3 1117.4 1124.0 9663.7 11166.9 11191.6 11193.7 11277.0 483708.0 490352.0 507100.0 532067.0 536590.0 52155.0 54081.0 79351.6 83048.6 89419.0 1191.3 1218.6 1225.7 1231.2 1235.0 17992.4 18005.7 18055.7 18072.8 18459.0 35199.9 38203.2 39295.8 39895.8 40337.6 51785.0 53819.5 54086.5 54377.0 54531.2 8704.5 8944.9 9076.9 9099.9 9333.4 10029.4 13161.8 13268.9 13454.0 13487.5 11496.0 11583.9 11720.4 11761.2 12244.3 11274.7 11539.8 11690.9 11726.2 11840.9 11337.1 11838.3 11856.4 11923.9 12156.9 8846.0 8961.1 9053.5 9076.5 9090.6 11413.3 11917.7 11938.9 11956.8 12102.3 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#3] mootools.html Cycles:180 Average:5757.80 Median:2748.83 stddev:3143.54 (114.4%) stddev-sans-first:3136.94 10:48:41 INFO - PROCESS | 23332 | Values: 1614.6 1625.3 1823.8 1940.5 1948.4 7701.7 8280.8 8396.8 8592.4 8603.2 8047.8 8143.1 8214.3 8244.5 8259.7 2369.1 2384.4 2385.7 2387.7 2398.8 2298.8 2313.1 2336.9 2341.8 2343.6 2419.1 2426.5 2438.7 2457.3 2460.8 2379.0 2394.4 2411.1 2415.4 2473.2 2394.9 2424.5 2430.6 2432.9 2436.7 8786.6 8824.0 8834.9 8837.6 8839.5 5387.1 5519.1 5534.9 5544.1 5544.6 3401.6 3463.1 3474.4 3498.9 3524.1 1076.5 1109.3 1131.2 1167.7 1170.2 12174.8 12227.4 12228.7 12235.3 12331.6 4605.2 4615.9 4626.6 4696.6 4706.5 10477.5 10515.2 10519.9 10537.0 10545.6 5398.3 5435.1 5439.1 5444.6 5451.4 4839.2 4998.6 5039.5 5061.1 5068.0 3973.6 3994.1 4068.3 4086.4 4112.5 1145.9 1294.3 1296.9 1298.1 1304.7 1104.1 1117.6 1119.8 1122.5 1130.3 6114.4 6141.3 6178.6 6181.7 6208.6 479.8 482.1 488.7 499.0 1112.6 4309.1 4333.6 4363.2 4370.6 4375.9 10120.9 10178.5 10451.1 10475.0 10524.8 10153.7 10182.0 10250.5 10284.2 10312.1 7895.2 7967.3 8053.3 8147.1 8165.8 6121.5 6180.4 6188.6 6189.2 6207.1 9307.5 9470.8 9526.7 9567.5 9638.3 9228.1 9517.2 9718.7 9911.3 9926.5 6839.0 7472.1 7673.7 7676.8 7788.8 8181.2 8195.7 8212.6 8216.7 8269.3 7150.9 7454.6 7492.6 7555.7 7606.2 7307.4 7343.2 7400.9 7431.9 7493.1 7085.7 7165.0 7267.9 7300.3 7313.0 5361.9 5448.7 5485.6 5588.1 5601.9 5365.6 5366.9 5392.9 5470.7 5477.5 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#4] prototype.html Cycles:180 Average:5788.61 Median:6645.92 stddev:1772.32 (26.7%) stddev-sans-first:1729.82 10:48:41 INFO - PROCESS | 23332 | Values: 360.2 370.0 370.7 375.2 379.9 6407.4 6441.1 6538.8 6545.1 6564.5 6519.4 6548.6 6555.0 6565.7 6566.7 4949.9 4950.1 4962.5 4964.4 4969.9 4974.8 4974.9 4975.1 4977.4 4988.2 4934.4 4946.8 4948.6 4954.1 4960.0 4700.6 4828.7 4947.5 4951.8 4951.8 4234.7 4248.7 4266.0 4285.1 4286.6 6154.7 6230.3 6243.6 6256.3 6265.4 5709.8 5711.1 5712.9 5727.3 5737.7 6802.9 6837.0 6859.3 6864.3 6883.1 4593.2 4706.6 4771.8 4776.3 4777.0 7131.0 7133.7 7143.9 7191.9 7196.5 4857.1 4857.2 4858.6 4858.9 4870.7 4911.6 4916.1 4916.8 4931.2 4937.2 5684.5 5697.9 5706.3 5709.4 5715.3 6794.7 6876.9 6886.9 6906.9 6918.7 1675.8 1685.6 1696.6 1699.4 1700.7 1109.7 1127.1 1127.2 1131.8 1145.0 6704.5 6711.8 6716.7 6733.4 6735.7 7105.8 7106.1 7121.5 7126.0 7141.0 6675.0 6722.6 6727.5 6727.6 6729.1 3807.4 3851.4 3852.4 3853.7 3859.0 7313.2 7569.7 7590.3 7616.6 7629.4 7304.9 7312.3 7313.7 7323.1 7327.7 7531.0 7542.9 7554.1 7559.6 7577.0 6911.9 7208.8 7213.6 7223.9 7230.0 6959.3 7017.1 7019.6 7024.7 7056.8 7544.3 7547.6 7549.4 7551.5 7567.4 4875.2 4888.0 4907.6 4917.2 4925.0 7053.6 7146.8 7164.8 7191.7 7195.9 6941.3 6944.4 6953.1 6953.9 6978.9 6868.5 6870.8 6939.8 6941.4 6951.2 6822.4 6827.5 6855.5 6896.3 6899.2 6823.3 6978.9 6981.6 6983.6 6988.3 6616.9 6836.9 6844.7 6845.5 6870.7 10:48:41 INFO - PROCESS | 23332 | 10:48:41 INFO - PROCESS | 23332 | [#5] yui.html Cycles:180 Average:15273.59 Median:20633.85 stddev:17082.82 (82.8%) stddev-sans-first:17096.52 10:48:41 INFO - PROCESS | 23332 | Values: 876.6 891.1 903.6 937.2 951.2 14813.2 15020.5 15054.1 15072.5 15089.7 14297.7 14719.3 14882.4 14885.0 14927.7 932.7 941.3 952.7 956.8 957.2 953.7 955.4 966.4 967.2 968.9 1004.0 1004.3 1006.8 1008.2 1010.8 1000.9 1001.6 1001.9 1005.4 1007.0 740.1 740.3 741.2 741.6 743.3 15221.4 15268.7 15298.8 15310.9 15335.5 14577.6 14640.6 14674.9 14675.4 14692.3 11583.7 11711.4 11715.0 11861.1 11938.3 3773.8 3809.3 3834.4 3844.0 3846.4 54617.2 54618.2 55365.4 55435.0 55785.0 11455.9 11659.0 11704.0 11752.4 11919.8 20583.1 20914.3 20963.0 20995.5 21058.8 7611.3 7989.5 8048.1 8085.5 8340.6 5075.8 5078.2 5095.5 5106.1 5144.6 3641.5 3695.0 3714.5 3732.4 3736.7 634.1 647.0 649.4 656.7 672.8 758.1 787.8 791.4 791.6 810.2 9708.0 9919.4 9984.2 10048.3 10137.9 653.0 684.4 684.7 727.4 788.8 4455.3 4525.0 4529.4 4550.8 4596.0 62583.7 62866.0 63077.0 63278.7 63561.0 52391.2 54637.5 55441.7 55680.0 55870.0 45050.3 46364.0 49711.5 51414.2 51618.7 9358.8 9369.2 9487.0 9586.9 9589.2 33651.3 33671.7 35698.5 36829.8 37531.0 44094.8 44179.0 45331.1 45757.3 46350.8 12706.0 12723.3 12799.6 12853.8 12988.2 13101.8 13144.0 14208.4 14614.5 14639.3 13438.5 13547.7 13753.3 13997.9 14223.2 13214.4 13272.3 13283.1 13308.9 13335.8 13797.4 13841.4 13878.7 13895.4 13917.3 11424.2 11509.2 11645.2 11693.1 11818.3 11415.8 11608.8 11614.9 11722.4 11919.5 10:48:41 INFO - PROCESS | 23332 | -------- Summary: end -------- 10:48:41 INFO - PROCESS | 23332 | 10:48:42 INFO - TEST-INFO | 23332: exit 0 10:48:42 INFO - TEST-OK | dromaeo_css | took 1108792ms 10:48:42 INFO - TEST-START | kraken 10:48:42 INFO - operating with platform_type : linux_ 10:48:42 INFO - Initialising browser for kraken test... 10:48:42 INFO - TEST-INFO | started process 23570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1iBym/profile http://localhost:46866/getInfo.html) 10:48:46 INFO - PROCESS | 23570 | 10:48:46 INFO - PROCESS | 23570 | (process:23652): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:48:46 INFO - PROCESS | 23570 | __metrics Screen width/height:1600/1200 10:48:46 INFO - PROCESS | 23570 | colorDepth:24 10:48:46 INFO - PROCESS | 23570 | Browser inner width/height: 1024/697 10:48:46 INFO - PROCESS | 23570 | __metrics 10:48:47 ERROR - PROCESS | 23570 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:48:48 INFO - TEST-INFO | 23570: exit 0 10:48:48 INFO - Browser initialized. 10:48:48 INFO - Running cycle 1/1 for kraken test... 10:48:48 INFO - TEST-INFO | started process 23702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc1iBym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:50 INFO - PROCESS | 23702 | 10:48:50 INFO - PROCESS | 23702 | (process:23775): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:49:00 INFO - PROCESS | 23702 | RSS: Main: 150855680 10:49:00 INFO - PROCESS | 23702 | 10:49:02 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:03 INFO - PROCESS | 23702 | RSS: Main: 156512256 10:49:03 INFO - PROCESS | 23702 | 10:49:06 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-dft) 10:49:06 INFO - PROCESS | 23702 | RSS: Main: 156123136 10:49:06 INFO - PROCESS | 23702 | 10:49:09 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-fft) 10:49:10 INFO - PROCESS | 23702 | RSS: Main: 156291072 10:49:10 INFO - PROCESS | 23702 | 10:49:12 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46866/tests/kraken/driver.html?testName=audio-oscillator) 10:49:12 INFO - PROCESS | 23702 | RSS: Main: 156368896 10:49:12 INFO - PROCESS | 23702 | 10:49:15 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:15 INFO - PROCESS | 23702 | RSS: Main: 156160000 10:49:15 INFO - PROCESS | 23702 | 10:49:18 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:19 INFO - PROCESS | 23702 | RSS: Main: 156135424 10:49:19 INFO - PROCESS | 23702 | 10:49:22 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46866/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:23 INFO - PROCESS | 23702 | RSS: Main: 156409856 10:49:23 INFO - PROCESS | 23702 | 10:49:25 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46866/tests/kraken/driver.html?testName=json-parse-financial) 10:49:26 INFO - PROCESS | 23702 | RSS: Main: 156950528 10:49:26 INFO - PROCESS | 23702 | 10:49:28 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:28 INFO - PROCESS | 23702 | RSS: Main: 157134848 10:49:28 INFO - PROCESS | 23702 | 10:49:30 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:31 INFO - PROCESS | 23702 | RSS: Main: 156868608 10:49:31 INFO - PROCESS | 23702 | 10:49:33 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:33 INFO - PROCESS | 23702 | RSS: Main: 156868608 10:49:33 INFO - PROCESS | 23702 | 10:49:36 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:36 INFO - PROCESS | 23702 | RSS: Main: 157495296 10:49:36 INFO - PROCESS | 23702 | 10:49:39 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:40 INFO - PROCESS | 23702 | RSS: Main: 157212672 10:49:40 INFO - PROCESS | 23702 | 10:49:41 INFO - PROCESS | 23702 | Cycle 1(1): loaded http://localhost:46866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46866/tests/kraken/driver.html?testName=ai-astar) 10:49:42 INFO - PROCESS | 23702 | RSS: Main: 158400512 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | __start_tp_report 10:49:42 INFO - PROCESS | 23702 | _x_x_mozilla_page_load 10:49:42 INFO - PROCESS | 23702 | _x_x_mozilla_page_load_details 10:49:42 INFO - PROCESS | 23702 | |i|pagename|runs| 10:49:42 INFO - PROCESS | 23702 | |0;ai-astar;109;114;104;111;113;110;98;109;109;111 10:49:42 INFO - PROCESS | 23702 | |1;audio-beat-detection;157;128;152;177;133;149;151;128;183;127 10:49:42 INFO - PROCESS | 23702 | |2;audio-dft;162;163;164;161;163;161;163;161;163;162 10:49:42 INFO - PROCESS | 23702 | |3;audio-fft;77;74;73;179;75;78;77;77;167;76 10:49:42 INFO - PROCESS | 23702 | |4;audio-oscillator;93;92;159;93;92;92;157;92;92;139 10:49:42 INFO - PROCESS | 23702 | |5;imaging-gaussian-blur;117;118;117;117;118;117;119;117;117;117 10:49:42 INFO - PROCESS | 23702 | |6;imaging-darkroom;146;146;146;147;147;146;148;146;146;146 10:49:42 INFO - PROCESS | 23702 | |7;imaging-desaturate;100;95;95;97;94;95;95;95;95;95 10:49:42 INFO - PROCESS | 23702 | |8;json-parse-financial;55;55;56;54;56;60;56;80;54;57 10:49:42 INFO - PROCESS | 23702 | |9;json-stringify-tinderbox;60;59;59;59;59;58;59;59;59;60 10:49:42 INFO - PROCESS | 23702 | |10;stanford-crypto-aes;73;74;73;76;75;75;75;74;75;75 10:49:42 INFO - PROCESS | 23702 | |11;stanford-crypto-ccm;115;126;120;116;116;116;119;118;136;138 10:49:42 INFO - PROCESS | 23702 | |12;stanford-crypto-pbkdf2;163;161;159;167;162;164;164;159;159;160 10:49:42 INFO - PROCESS | 23702 | |13;stanford-crypto-sha256-iterative;69;64;66;67;67;67;66;66;63;66 10:49:42 INFO - PROCESS | 23702 | __end_tp_report 10:49:42 INFO - PROCESS | 23702 | __start_cc_report 10:49:42 INFO - PROCESS | 23702 | _x_x_mozilla_cycle_collect,838 10:49:42 INFO - PROCESS | 23702 | __end_cc_report 10:49:42 INFO - PROCESS | 23702 | __startTimestamp1466704182028__endTimestamp 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | ------- Summary: start ------- 10:49:42 INFO - PROCESS | 23702 | Number of tests: 14 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.66 (4.2%) stddev-sans-first:4.94 10:49:42 INFO - PROCESS | 23702 | Values: 109.0 114.0 104.0 111.0 113.0 110.0 98.0 109.0 109.0 111.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:151.50 stddev:20.10 (13.3%) stddev-sans-first:21.08 10:49:42 INFO - PROCESS | 23702 | Values: 157.0 128.0 152.0 177.0 133.0 149.0 151.0 128.0 183.0 127.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 10:49:42 INFO - PROCESS | 23702 | Values: 162.0 163.0 164.0 161.0 163.0 161.0 163.0 161.0 163.0 162.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.50 stddev:41.08 (53.7%) stddev-sans-first:43.03 10:49:42 INFO - PROCESS | 23702 | Values: 77.0 74.0 73.0 179.0 75.0 78.0 77.0 77.0 167.0 76.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.00 stddev:29.15 (31.7%) stddev-sans-first:30.26 10:49:42 INFO - PROCESS | 23702 | Values: 93.0 92.0 159.0 93.0 92.0 92.0 157.0 92.0 92.0 139.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:49:42 INFO - PROCESS | 23702 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 119.0 117.0 117.0 117.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:49:42 INFO - PROCESS | 23702 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 148.0 146.0 146.0 146.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:0.78 10:49:42 INFO - PROCESS | 23702 | Values: 100.0 95.0 95.0 97.0 94.0 95.0 95.0 95.0 95.0 95.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:56.00 stddev:7.82 (14.0%) stddev-sans-first:8.20 10:49:42 INFO - PROCESS | 23702 | Values: 55.0 55.0 56.0 54.0 56.0 60.0 56.0 80.0 54.0 57.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 10:49:42 INFO - PROCESS | 23702 | Values: 60.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 59.0 60.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 10:49:42 INFO - PROCESS | 23702 | Values: 73.0 74.0 73.0 76.0 75.0 75.0 75.0 74.0 75.0 75.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:119.50 stddev:8.52 (7.1%) stddev-sans-first:8.66 10:49:42 INFO - PROCESS | 23702 | Values: 115.0 126.0 120.0 116.0 116.0 116.0 119.0 118.0 136.0 138.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.50 stddev:2.70 (1.7%) stddev-sans-first:2.83 10:49:42 INFO - PROCESS | 23702 | Values: 163.0 161.0 159.0 167.0 162.0 164.0 164.0 159.0 159.0 160.0 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - PROCESS | 23702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.66 (2.5%) stddev-sans-first:1.39 10:49:42 INFO - PROCESS | 23702 | Values: 69.0 64.0 66.0 67.0 67.0 67.0 66.0 66.0 63.0 66.0 10:49:42 INFO - PROCESS | 23702 | -------- Summary: end -------- 10:49:42 INFO - PROCESS | 23702 | 10:49:42 INFO - TEST-INFO | 23702: exit 0 10:49:42 INFO - TEST-OK | kraken | took 60527ms 10:49:42 INFO - SUITE-END | took 1169s 10:49:43 INFO - Completed test suite (00:19:29) 10:49:43 INFO - javascript benchmark 10:49:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.6014078310604, 3360.6807353301438, 3396.592408910931, 3402.098443912362, 3404.7957122572648, 5642.830715078544, 5693.9715301423485, 5697.601167918237, 5703.885922281552, 5736.996025695502, 5683.488486036256, 5707.828765137053, 5714.200011998313, 5718.485336319731, 5770.624909380897, 5131.153359695655, 5145.86790906002, 5194.584433245332, 5195.428502864682, 5218.947810521884, 5149.768260428271, 5261.789528418859, 5278.392984806739, 5289.841304760864, 5300.787968481256, 5123.2827404163445, 5131.153359695664, 5171.146760784485, 5195.896082078356, 5319.6808191508635, 5182.274481572564, 5197.272381866523, 5199.740012999373, 5200.661956972823, 5205.141151709963, 5077.416097148801, 5085.516875896821, 5167.069927413064, 5172.456892026321, 5209.6874187548865, 5577.749001294951, 5591.580631452657, 5667.0, 5667.461591148875, 5704.172894930211, 6119.571629985903, 6136.447719705248, 6141.140240366352, 6149.2620885494025, 6157.815265541996, 6092.299385570627, 6188.628682279078, 6201.534884883652, 6202.038684003986, 6207.34822843604, 5701.486866182064, 5717.485426311652, 5751.166080918285, 5752.165935939307, 5782.739776710058, 6292.716827742763, 6315.96842015787, 6319.842003949938, 6322.462590679844, 6325.114483972247, 6045.486133678686, 6064.636121832704, 6067.423594758491, 6068.180795592539, 6110.5587591967305, 6120.081455037911, 6120.872274143302, 6144.8771024579255, 6148.754049838046, 6159.322474527888, 6081.847953801191, 6083.482903953125, 6083.756649733961, 6095.908561371494, 6112.113743507167, 6006.639601623917, 6067.423594758491, 6103.816885493442, 6110.358412366726, 6120.387961203933, 4646.83736069236, 4647.512011238839, 4649.395578574764, 4654.138984287918, 4683.929741053887, 4162.146759914211, 4169.291220492523, 4173.8956526087095, 4203.138356636882, 4227.725197862191, 5870.14882841994, 5900.852478687982, 5928.703564821828, 5947.702614869326, 5966.433188847052, 6136.355682653347, 6156.199694039746, 6182.1345011698395, 6193.535484838655, 6262.436380725757, 5857.26784151981, 5889.146073819272, 5942.0, 5946.256717910262, 5958.612690175211, 5178.6374953752875, 5294.0, 5339.81310654133, 5354.544863686552, 5366.838994830083, 6368.617882927039, 6373.5857169283845, 6378.936210637834, 6383.36166383358, 6384.074309225136, 6088.6042407243385, 6135.07973803933, 6138.202033735586, 6144.139820425144, 6146.815595532141, 6379.808605741835, 6481.935180648133, 6487.091807147098, 6490.0, 6497.0, 6029.276486821609, 6041.0, 6078.665673388006, 6079.3008803988105, 6085.361037091218, 6067.0, 6128.900367973304, 6193.009118541012, 6196.721147548461, 6201.441870231701, 6001.279846418458, 6046.939530604814, 6055.697215139314, 6059.091136329585, 6093.695315234309, 5996.610220335664, 6043.516518678407, 6047.334793172659, 6048.818535443944, 6052.939470605237, 5794.449527294901, 5802.564807639359, 5853.707314634336, 5960.791372301948, 5967.015442451947, 5986.281646202484, 6023.608465449732, 6038.51691864641, 6042.5770196087615, 6075.544334175043, 5888.646681199141, 5907.586468947133, 5912.408759124053, 5913.881722365614, 5918.881622367615], "value": 5665.872174798187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.1647940074906, 678.4640134293908, 682.4063065133334, 687.4431710314644, 734.4161391693607, 32359.0, 33177.50233746496, 39692.0, 39817.80091099541, 40339.59660403395, 42407.78796106015, 43019.56980430195, 43054.78472607632, 43113.35329970045, 43153.35269970953, 8856.424332418404, 8967.327450441211, 8990.460572365679, 9017.053209413016, 9027.819443611124, 8724.563771811385, 8854.158854908774, 8861.778455538599, 8884.244839188677, 8894.066123057082, 8803.251723603502, 9168.587413566405, 9172.633094676205, 9181.40320879144, 9195.540222988857, 9072.682456114037, 9084.046175151612, 9104.726858194199, 9109.68116115936, 9145.039770824034, 8901.332400070021, 8996.415233009833, 9034.14175653312, 9041.095890410972, 9044.819103617956, 43145.35281970773, 43519.129617407794, 43520.564794351965, 43554.564454355364, 43635.78182109101, 3769.4534292527705, 4066.085130845566, 4240.024794297298, 4250.4899412070445, 4445.333200019991, 33710.32579348399, 33962.1509462263, 34087.14782130442, 34274.14314642154, 34534.0, 4432.667549933768, 4489.124620698965, 4521.547845215485, 4545.318202269686, 4563.817447302137, 323497.0, 326211.36894315615, 326860.0, 328373.0, 329177.0, 61891.381086188565, 62210.688946554976, 62213.0, 62250.0, 62565.37434625687, 69433.30566694369, 70116.29883701098, 70772.0, 70803.0, 70837.0, 18617.627647447247, 18849.623007539773, 18862.339818106302, 18886.81113188878, 18927.716084258747, 14057.578272651837, 14076.507322243673, 14078.648033799032, 14099.0, 14107.0, 20636.17455301771, 21230.0, 21298.25456109029, 21367.8931605341, 21374.0, 7742.303192712683, 7787.649555769891, 7959.005124359455, 8005.119436861941, 8041.6381262843315, 1124.1905827803969, 1139.5897476908306, 1149.9937554639691, 1187.382561068257, 1240.6464157715188, 32652.346953060805, 32691.0, 32955.50566741501, 33124.58520666049, 33184.502232466046, 1199.0946835139414, 1231.719773786086, 1237.5421094195206, 1266.202292555684, 1289.9548515801903, 17116.400925967533, 17230.569235769206, 17360.39238626642, 17414.47756567305, 17602.94382337064, 429407.0, 509403.0, 512562.0, 519068.0, 519505.0, 62926.37073629296, 63356.683216583624, 63642.36357636364, 63990.36009639844, 64086.679566601866, 1481.8060507080506, 1540.784290199373, 1556.2141118734967, 1571.8663913567245, 1578.928948197334, 32766.0, 33665.326693465504, 33679.83160084184, 33980.0, 34401.96794096181, 53365.19952200643, 53872.73063634813, 54036.459635403146, 54157.0, 54220.18669720036, 439112.0, 439203.0, 439866.0, 440790.0, 440998.0, 30950.690493094782, 31710.36579268448, 31759.52360714545, 31776.364472709953, 32033.67966320307, 49550.0, 50337.49662503328, 50608.493915060375, 50754.0, 51975.480245198574, 41498.79250603728, 41996.580034199265, 42760.572394276904, 43167.13665726731, 43487.347689784045, 41083.0, 42102.84527269287, 42454.78772606117, 42803.571964281204, 43035.3544696836, 35959.28081438409, 43031.13937721291, 43243.0, 43339.78330108329, 43582.56417435785, 32982.50526242156, 34209.0, 34209.31581368409, 34247.0, 34339.4849077269, 26912.32719182036, 27391.315217119733, 28471.715282846908, 29020.56469152922, 29073.273168170967], "value": 21050.68082025775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.51653938936863, 446.667857780954, 447.6776720761055, 453.5034137619306, 454.97270163790176, 18570.814291857096, 19179.32872349468, 19289.0, 21018.159273629073, 21047.47381315468, 20054.398368048944, 20414.183432662714, 20525.178992840305, 20583.0, 20645.0, 5443.319585051859, 5893.351731309574, 5902.2622172228475, 5910.704464776765, 5916.0, 5741.540676745851, 5833.066709326508, 5839.970800146015, 5840.328362238354, 5842.152887831262, 5614.2701448811595, 5768.971155144219, 5780.335261444946, 5781.306243250816, 5801.129830525434, 5730.885382292352, 5798.217240672498, 5814.883702325951, 5818.941810581925, 5820.708964551798, 5094.235864620299, 5244.685318880879, 5264.7367631618645, 5301.125314323171, 5305.628605997582, 23173.420664483354, 23300.65049024249, 23655.645165322534, 23851.045958161652, 23891.0, 2502.099244272061, 2573.1251374532562, 2618.7250338714352, 2682.1417146512927, 2984.5373967035143, 14641.70716585673, 14980.325885335076, 15263.618409539738, 15415.15216663083, 15472.071675699493, 1943.815337542931, 1982.544014876572, 2069.0, 2071.2129390831537, 2126.2345555599973, 73785.6310718443, 75244.0, 77168.61415692941, 78936.0, 79004.60497697475, 10659.307145035547, 10673.0, 11138.33170009802, 11147.386893720923, 11551.595694150665, 15523.379064837505, 15526.922365388327, 15631.68736625261, 15642.45251416195, 15683.451079212173, 7920.762377128695, 8282.0, 8310.626021828912, 8566.229039386486, 8614.310855131574, 8297.170282971654, 8302.335813134934, 8304.875426868603, 8344.374171937128, 8379.455335403301, 5082.186850103965, 5094.872628184325, 5125.666831656005, 5166.3025491558155, 5243.475652434726, 1980.8705641435515, 2034.4506983114773, 2139.1443422631073, 2148.5917675641576, 2155.967660485094, 1003.4481035430484, 1086.380762965118, 1109.57836022311, 1157.9942100289445, 1172.94135293235, 16757.58106047334, 19232.61534769297, 19530.414087577396, 19811.405657830288, 19908.0, 1050.9527071281657, 1102.1843835561788, 1102.3165637304921, 1117.4189421500937, 1123.9775204495863, 9663.710088697351, 11166.944165279285, 11191.608293709682, 11193.66419007431, 11277.0, 483708.0, 490352.0, 507100.0, 532067.0, 536590.0, 52155.0, 54081.0, 79351.60324198342, 83048.58475707583, 89419.0, 1191.303087693709, 1218.5795900414344, 1225.66906935127, 1231.2181764579557, 1234.950601975929, 17992.37026704059, 18005.72991405156, 18055.729164062286, 18072.819271807115, 18459.0, 35199.94400167999, 38203.23593528169, 39295.80352098221, 39895.80052099837, 40337.59662403339, 51785.0, 53819.46180538145, 54086.45913540814, 54377.0, 54531.18203227034, 8704.477731336141, 8944.910550894669, 9076.863847042432, 9099.863502047343, 9333.439993600407, 10029.398236105857, 13161.802572961222, 13268.933655332048, 13454.0, 13487.460501580219, 11496.0, 11583.942080289882, 11720.355380454157, 11761.235519691192, 12244.265344079384, 11274.718132046764, 11539.8269025963, 11690.941545292219, 11726.237794543327, 11840.881591184323, 11337.149713771336, 11838.28970261787, 11856.407179641155, 11923.880761192277, 12156.939215303866, 8845.955770221108, 8961.148690874357, 9053.547322633975, 9076.455412675261, 9090.636374544943, 11413.315201087962, 11917.702057448287, 11938.940305298418, 11956.820647690465, 12102.334371609646], "value": 9524.951007414713, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1614.6124930016797, 1625.2686291168977, 1823.772028496438, 1940.5051711813476, 1948.3959972408563, 7701.691932322715, 8280.83438331233, 8396.790080247989, 8592.398532102747, 8603.225709686134, 8047.758567242978, 8143.144969778177, 8214.342852571795, 8244.54654993975, 8259.669613215465, 2369.0642196332437, 2384.3681424422543, 2385.7137143542714, 2387.6537902004284, 2398.8440751351104, 2298.793108620224, 2313.086330899294, 2336.906523739048, 2341.8243631727605, 2343.5547246023284, 2419.129113519132, 2426.454047839231, 2438.67077944477, 2457.299669594166, 2460.753924607543, 2378.9643155352683, 2394.413368724665, 2411.071737381112, 2415.3720032791425, 2473.2332976777257, 2394.856308621488, 2424.515096980611, 2430.647556104355, 2432.9391765205833, 2436.7441418650965, 8786.60460279289, 8823.955880220621, 8834.911650883538, 8837.60230789616, 8839.513826739527, 5387.084195686703, 5519.089350257203, 5534.916976245359, 5544.112941929272, 5544.556435485151, 3401.6088149862835, 3463.0649724574223, 3474.4267195912644, 3498.8775392861126, 3524.101354154674, 1076.5424694504804, 1109.290054365207, 1131.2251107991053, 1167.7372591167004, 1170.1808733886314, 12174.756504869942, 12227.449764760608, 12228.694282642917, 12235.32705701186, 12331.568395106127, 4605.240135377692, 4615.9076818463445, 4626.629869610423, 4696.60078893291, 4706.458757242961, 10477.52851121686, 10515.158787296998, 10519.894801052045, 10537.0, 10545.630902918361, 5398.325209348832, 5435.103207970719, 5439.075357189287, 5444.646098003696, 5451.427600102012, 4839.177339852234, 4998.625103117281, 5039.496050395004, 5061.139606266944, 5067.974660126676, 3973.5827738087664, 3994.08136128692, 4068.2677118119022, 4086.4483294755423, 4112.547619761824, 1145.8911403416662, 1294.3140135728079, 1296.9092163548462, 1298.0848501806204, 1304.6933970517111, 1104.1292639138337, 1117.5920788911988, 1119.764849381639, 1122.4892673833385, 1130.2540323386525, 6114.419130182626, 6141.324454310023, 6178.567500274938, 6181.660008699475, 6208.565400421927, 479.79608666316676, 482.07441711913214, 488.6603810351771, 499.02938784064645, 1112.5605385872698, 4309.07354918694, 4333.609975102256, 4363.170997510463, 4370.562943705668, 4375.934360984587, 10120.949395252977, 10178.541965611417, 10451.111655509214, 10475.0, 10524.842127368096, 10153.746156346151, 10182.032706892833, 10250.53872575721, 10284.228682848816, 10312.123469505175, 7895.249951254622, 7967.322777563856, 8053.315468185153, 8147.103818579952, 8165.795855103551, 6121.540884433774, 6180.412860778219, 6188.628682279078, 6189.226346706661, 6207.068939659087, 9307.534623268944, 9470.763230919007, 9526.714198574055, 9567.521623918916, 9638.277129215478, 9228.123328283802, 9517.238620910171, 9718.70843874685, 9911.256655750703, 9926.503674816086, 6839.0, 7472.103347598323, 7673.731419400294, 7676.808079797826, 7788.805279867822, 8181.222783835526, 8195.67217311301, 8212.630431630472, 8216.712415065684, 8269.29710974574, 7150.928490715026, 7454.589997550187, 7492.587907665131, 7555.73554925575, 7606.163322034461, 7307.378872795872, 7343.192248852515, 7400.851982960418, 7431.888521672287, 7493.138289096823, 7085.716571337089, 7165.0327205828635, 7267.854642907007, 7300.342969132804, 7313.012743279589, 5361.946380536301, 5448.673079615236, 5485.561155107662, 5588.077967135378, 5601.887962240814, 5365.624406291522, 5366.919496207638, 5392.921415716951, 5470.671759694431, 5477.507024367826], "value": 4641.565267384332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.2273124148701, 369.97410181287313, 370.6682519145365, 375.198950241235, 379.8784388995519, 6407.359264073591, 6441.130447389601, 6538.803835884931, 6545.116409284745, 6564.540482166244, 6519.380658837403, 6548.607083574989, 6554.967225163879, 6565.737370505174, 6566.671666416684, 4949.876253093684, 4950.059488697145, 4962.528559786814, 4964.354633897588, 4969.925451118236, 4974.8258810941625, 4974.875628109308, 4975.054739599483, 4977.3529441172595, 4988.226824842137, 4934.40787105546, 4946.802127914879, 4948.604111671058, 4954.108260513106, 4960.0, 4700.576948074656, 4828.661993660445, 4947.480514545975, 4951.752412379366, 4951.826686065989, 4234.745915245096, 4248.745075295461, 4266.0, 4285.142971405731, 4286.571342865688, 6154.661493617849, 6230.314665386803, 6243.594166379171, 6256.311805701369, 6265.404786545271, 5709.828705138811, 5711.05767548354, 5712.914306285409, 5727.341355744101, 5737.684427356494, 6802.863942721118, 6836.965815170893, 6859.31406859315, 6864.322914063519, 6883.139607549057, 4593.150267200579, 4706.647001474903, 4771.8091276348905, 4776.331313616097, 4777.044591081798, 7131.001659767637, 7133.678984445713, 7143.857122857514, 7191.885257785052, 7196.46026548011, 4857.077155340474, 4857.1742803723455, 4858.611311095104, 4858.854234372974, 4870.683405578626, 4911.557959783637, 4916.115099282092, 4916.754162291871, 4931.235658472942, 4937.23472861707, 5684.516816070681, 5697.857553561112, 5706.28671416073, 5709.429057094258, 5715.342735585377, 6794.694238759268, 6876.896846547305, 6886.896696549556, 6906.930930690729, 6918.688659010357, 1675.8240384759424, 1685.5954570902895, 1696.550414140254, 1699.405208177128, 1700.6938751024686, 1109.7225693576606, 1127.0532752487786, 1127.2222166704948, 1131.7623299107115, 1145.0210070389862, 6704.497162712816, 6711.832204194837, 6716.664166791641, 6733.393994540417, 6735.696893639798, 7105.786826395217, 7106.076210092759, 7121.537100088478, 7125.96437017822, 7140.964295178491, 6674.9666251669405, 6722.563033402813, 6727.495437842083, 6727.596344219362, 6729.1252137221845, 3807.371783655721, 3851.4030325299623, 3852.4028775539837, 3853.7495062820826, 3859.0352411897024, 7313.2321106284135, 7569.697212111564, 7590.316871481593, 7616.619169041525, 7629.389648828081, 7304.853902921912, 7312.305330993547, 7313.707451701979, 7323.12122545298, 7327.74352897646, 7530.962345188349, 7542.924570754332, 7554.093508778982, 7559.584222867685, 7577.014988051518, 6911.861762764817, 7208.819779505554, 7213.567185968649, 7223.855522889407, 7230.0, 6959.269276726073, 7017.05269788572, 7019.613921234177, 7024.683889225099, 7056.7530136444975, 7544.321011109027, 7547.622618869144, 7549.433792465477, 7551.471397002377, 7567.356774673995, 4875.219964805614, 4888.0468308679465, 4907.582855457326, 4917.213245880642, 4924.9507504924495, 7053.647317634201, 7146.785596432115, 7164.785056448315, 7191.748288809867, 7195.856082878208, 6941.305869413019, 6944.375006249462, 6953.130858642669, 6953.895691564731, 6978.860422791414, 6868.484863635147, 6870.828229294108, 6939.757108501179, 6941.444684425335, 6951.200611929693, 6822.351876571718, 6827.52207345481, 6855.520113592001, 6896.310368963063, 6899.172099347909, 6823.317668233335, 6978.930210698031, 6981.616011119438, 6983.615901125284, 6988.301169883174, 6616.867662646817, 6836.93163068363, 6844.691988860413, 6845.520813543004, 6870.656467176721], "value": 5209.0524459166545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.6274333408301, 891.1355984694852, 903.5617725403179, 937.2455173585261, 951.1914872358496, 14813.18527480988, 15020.549383518499, 15054.096754194756, 15072.47246346378, 15089.698206035873, 14297.714045719105, 14719.337629806658, 14882.404703811862, 14885.032472889254, 14927.701445971074, 932.7201839448138, 941.2517048946104, 952.6570434643522, 956.7799406136593, 957.2389949989774, 953.7377221264173, 955.3885513271512, 966.352543795655, 967.1875624475439, 968.8982656821038, 1003.989960100397, 1004.2719028704167, 1006.7986402719449, 1008.2035192198191, 1010.8129995950736, 1000.9149222316112, 1001.6344034427418, 1001.9248556358266, 1005.3666190300064, 1007.0382784440878, 740.0786021403387, 740.256042677106, 741.2402287655143, 741.5773009384653, 743.2901578992049, 15221.391144354213, 15268.694626107415, 15298.847011529964, 15310.923445382814, 15335.463258786, 14577.562673119717, 14640.560783176521, 14674.853251467455, 14675.412983480648, 14692.26538673062, 11583.6524904253, 11711.414429278502, 11715.0, 11861.110416718695, 11938.283702977762, 3773.8301776419853, 3809.257194847006, 3834.3864981603087, 3844.0, 3846.4230365445405, 54617.1807422885, 54618.180727289124, 55365.44634553643, 55435.0, 55785.0, 11455.885441145481, 11659.0, 11704.0, 11752.412379380996, 11919.821202681967, 20583.07376168076, 20914.268000619904, 20963.0, 20995.47511312199, 21058.78941210599, 7611.2769286917655, 7989.480683755537, 8048.114707382183, 8085.474444161111, 8340.62467188978, 5075.822346217865, 5078.238264260391, 5095.515925987025, 5106.131957567148, 5144.562712169508, 3641.453781932731, 3694.9815250923575, 3714.4799728038097, 3732.402815549499, 3736.7010639148803, 634.0869148426251, 647.0391468669022, 649.4285029174297, 656.6880731652427, 672.8149758816267, 758.1130077808976, 787.8345547434989, 791.4262159934117, 791.5962858941866, 810.1695761844157, 9707.951460242653, 9919.355241909252, 9984.15134713543, 10048.29661923673, 10137.949310253402, 652.954293199481, 684.387473211473, 684.7192651013061, 727.3817255333031, 788.8225149341353, 4455.26488129455, 4524.9547504524535, 4529.433820772403, 4550.772461376918, 4596.0, 62583.6870815643, 62866.0, 63077.0, 63278.683606581675, 63561.0, 52391.21413178805, 54637.45362546323, 55441.72279138659, 55680.0, 55870.0, 45050.32424513635, 46363.99999999932, 49711.50288497141, 51414.22878656823, 51618.741906290226, 9358.766030849283, 9369.203617692572, 9486.95256523713, 9586.90413095888, 9589.232861371212, 33651.326973460884, 33671.663283366855, 35698.46452303269, 36829.815850920575, 37531.0, 44094.77952610217, 44179.0, 45331.09337813159, 45757.31364029476, 46350.76824615855, 12706.0, 12723.346935541205, 12799.552015679406, 12853.807192892302, 12988.220706757626, 13101.803472948104, 13144.0, 14208.360623771749, 14614.488492902698, 14639.341229644904, 13438.529651462151, 13547.661308467366, 13753.312334383441, 13997.860021399656, 14223.217723025333, 13214.405351759002, 13272.315785792529, 13283.070185086952, 13308.93345533266, 13335.799963000756, 13797.379117939516, 13841.446342146604, 13878.72242555123, 13895.444182232597, 13917.304134793423, 11424.200305978502, 11509.194356394972, 11645.184837061324, 11693.064554835762, 11818.349990750246, 11415.771684566429, 11608.825867611824, 11614.88791118761, 11722.41387930583, 11919.523219071487], "value": 7201.988477061979, "unit": "score"}], "name": "dromaeo_css", "value": 7633.405581319008, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 104.0, 111.0, 113.0, 110.0, 98.0, 109.0, 109.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 152.0, 177.0, 133.0, 149.0, 151.0, 128.0, 183.0, 127.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 161.0, 163.0, 161.0, 163.0, 161.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 73.0, 179.0, 75.0, 78.0, 77.0, 77.0, 167.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 159.0, 93.0, 92.0, 92.0, 157.0, 92.0, 92.0, 139.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 97.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 56.0, 60.0, 56.0, 80.0, 54.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 76.0, 75.0, 75.0, 75.0, 74.0, 75.0, 75.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 126.0, 120.0, 116.0, 116.0, 116.0, 119.0, 118.0, 136.0, 138.0], "value": 122.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 159.0, 167.0, 162.0, 164.0, 164.0, 159.0, 159.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 63.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1526.1999999999998, "alertThreshold": 2.0}]} 10:49:43 INFO - Return code: 0 10:49:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:49:43 ERROR - # TBPL SUCCESS # 10:49:43 INFO - Running post-action listener: _resource_record_post_action 10:49:43 INFO - Running post-run listener: _resource_record_post_run 10:49:44 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 462622720; Read time: 0; Write time: 366464 10:49:44 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 231849984; Read time: 0; Write time: 251184 10:49:44 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220278784; Read time: 0; Write time: 113880 10:49:44 INFO - Running post-run listener: _upload_blobber_files 10:49:44 INFO - Blob upload gear active. 10:49:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:44 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:49:44 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:49:44 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:49:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:49:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:49:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:45 INFO - (blobuploader) - INFO - Done attempting. 10:49:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:49:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:49:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:46 INFO - (blobuploader) - INFO - Done attempting. 10:49:46 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:46 INFO - Return code: 0 10:49:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d27f263af0655354e5799d59a720d25ac3d2e6deda580d51e80ea56df64c432f55d5c563f805546c2cbc35ec34532a83e63cb006ed32b8fdb185d8af9d6a72e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f21230d4ef5e991d6e6e40a8c505932e6b94b9500a2f3d9242c143c81673eac0583e665a7b6a01170c8347bda4b575d35fb0392fc9ce8b7dfbb87234d591317f"} 10:49:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:46 INFO - Contents: 10:49:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d27f263af0655354e5799d59a720d25ac3d2e6deda580d51e80ea56df64c432f55d5c563f805546c2cbc35ec34532a83e63cb006ed32b8fdb185d8af9d6a72e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f21230d4ef5e991d6e6e40a8c505932e6b94b9500a2f3d9242c143c81673eac0583e665a7b6a01170c8347bda4b575d35fb0392fc9ce8b7dfbb87234d591317f"} 10:49:46 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:46 INFO - Copying logs to upload dir... 10:49:46 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.539765 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-06-23 10:49:46.258969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:46.263021) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 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/d27f263af0655354e5799d59a720d25ac3d2e6deda580d51e80ea56df64c432f55d5c563f805546c2cbc35ec34532a83e63cb006ed32b8fdb185d8af9d6a72e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f21230d4ef5e991d6e6e40a8c505932e6b94b9500a2f3d9242c143c81673eac0583e665a7b6a01170c8347bda4b575d35fb0392fc9ce8b7dfbb87234d591317f"} build_url:https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/GcxKJmgjSruBB-0hdjGlUw/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/d27f263af0655354e5799d59a720d25ac3d2e6deda580d51e80ea56df64c432f55d5c563f805546c2cbc35ec34532a83e63cb006ed32b8fdb185d8af9d6a72e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f21230d4ef5e991d6e6e40a8c505932e6b94b9500a2f3d9242c143c81673eac0583e665a7b6a01170c8347bda4b575d35fb0392fc9ce8b7dfbb87234d591317f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:46.289939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:46.290292) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466702960.832309-2101734351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 10:49:46.373867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:49:46.374201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 10:49:46.374530) ========= ========= Total master_lag: 0.18 =========