builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1460644638.88 results: success (0) buildid: 20160414043111 builduid: 4600959711fb43c6b2a836714b46c6dd revision: 55b6f17f513ceadf145c8b0600ab06a68c55cf34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:18.876086) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:18.877382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:18.877661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:18.887390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:18.887652) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 07:37:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-04-14 07:37:19 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158223 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:19.056828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:19.057159) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015695 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:19.107942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 07:37:19.108297) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 55b6f17f513ceadf145c8b0600ab06a68c55cf34 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 55b6f17f513ceadf145c8b0600ab06a68c55cf34 --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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 07:37:19,653 truncating revision to first 12 chars 2016-04-14 07:37:19,654 Setting DEBUG logging. 2016-04-14 07:37:19,654 attempt 1/10 2016-04-14 07:37:19,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/55b6f17f513c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 07:37:20,622 unpacking tar archive at: mozilla-inbound-55b6f17f513c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238656 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 07:37:20.359801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:20.360156) ========= script_repo_revision: 55b6f17f513ceadf145c8b0600ab06a68c55cf34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:20.360576) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:20.360857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 07:37:20.369365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-14 07:37:20.369638) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:20 INFO - MultiFileLogger online at 20160414 07:37:20 in /builds/slave/test 07:37:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:37:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:21 INFO - {'append_to_log': False, 07:37:21 INFO - 'base_work_dir': '/builds/slave/test', 07:37:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:37:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:21 INFO - 'branch': 'Mozilla-Inbound', 07:37:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:21 INFO - 'config_files': ('talos/linux_config.py',), 07:37:21 INFO - 'default_actions': ('clobber', 07:37:21 INFO - 'read-buildbot-config', 07:37:21 INFO - 'download-and-extract', 07:37:21 INFO - 'populate-webroot', 07:37:21 INFO - 'create-virtualenv', 07:37:21 INFO - 'install', 07:37:21 INFO - 'run-tests'), 07:37:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:21 INFO - 'download_minidump_stackwalk': True, 07:37:21 INFO - 'download_symbols': 'ondemand', 07:37:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:21 INFO - 'installer_path': 'installer.exe', 07:37:21 INFO - 'log_level': 'info', 07:37:21 INFO - 'log_name': 'talos', 07:37:21 INFO - 'log_to_console': True, 07:37:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:21 INFO - 'opt_config_files': (), 07:37:21 INFO - 'pip_index': False, 07:37:21 INFO - 'sps_profile': False, 07:37:21 INFO - 'sps_profile_interval': 0, 07:37:21 INFO - 'suite': 'dromaeojs-e10s', 07:37:21 INFO - 'system_bits': '32', 07:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:21 INFO - 'title': 'talos-linux64-ix-066', 07:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:21 INFO - 'use_talos_json': True, 07:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:21 INFO - 'work_dir': 'build'} 07:37:21 INFO - ##### 07:37:21 INFO - ##### Running clobber step. 07:37:21 INFO - ##### 07:37:21 INFO - Running pre-action listener: _resource_record_pre_action 07:37:21 INFO - Running main action method: clobber 07:37:21 INFO - rmtree: /builds/slave/test/build 07:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:21 INFO - Running post-action listener: _resource_record_post_action 07:37:21 INFO - ##### 07:37:21 INFO - ##### Running read-buildbot-config step. 07:37:21 INFO - ##### 07:37:21 INFO - Running pre-action listener: _resource_record_pre_action 07:37:21 INFO - Running main action method: read_buildbot_config 07:37:21 INFO - Using buildbot properties: 07:37:21 INFO - { 07:37:21 INFO - "project": "", 07:37:21 INFO - "product": "firefox", 07:37:21 INFO - "script_repo_revision": "production", 07:37:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:37:21 INFO - "repository": "", 07:37:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:37:21 INFO - "buildid": "20160414043111", 07:37:21 INFO - "pgo_build": "True", 07:37:21 INFO - "basedir": "/builds/slave/test", 07:37:21 INFO - "buildnumber": 924, 07:37:21 INFO - "slavename": "talos-linux64-ix-066", 07:37:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:21 INFO - "platform": "ubuntu64_hw", 07:37:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:37:21 INFO - "branch": "mozilla-inbound", 07:37:21 INFO - "repo_path": "integration/mozilla-inbound", 07:37:21 INFO - "revision": "55b6f17f513ceadf145c8b0600ab06a68c55cf34", 07:37:21 INFO - "stage_platform": "linux64-pgo", 07:37:21 INFO - "builduid": "4600959711fb43c6b2a836714b46c6dd", 07:37:21 INFO - "slavebuilddir": "test" 07:37:21 INFO - } 07:37:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:37:21 INFO - Running post-action listener: _resource_record_post_action 07:37:21 INFO - ##### 07:37:21 INFO - ##### Running download-and-extract step. 07:37:21 INFO - ##### 07:37:21 INFO - Running pre-action listener: _resource_record_pre_action 07:37:21 INFO - Running main action method: download_and_extract 07:37:21 INFO - mkdir: /builds/slave/test/build/tests 07:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:21 INFO - https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:24 INFO - Downloaded 1361 bytes. 07:37:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:37:24 INFO - Using the following test package requirements: 07:37:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'jsshell-linux-x86_64.zip'], 07:37:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:24 INFO - https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:27 INFO - Downloaded 23775911 bytes. 07:37:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:28 INFO - Return code: 0 07:37:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:28 INFO - https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:31 INFO - Downloaded 23775911 bytes. 07:37:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:32 INFO - Return code: 0 07:37: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')]} 07:37:32 INFO - https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:34 INFO - Downloaded 10841076 bytes. 07:37:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:37:34 INFO - Return code: 0 07:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:34 INFO - https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:36 INFO - Downloaded 58155654 bytes. 07:37:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:37:36 INFO - mkdir: /builds/slave/test/properties 07:37:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:36 INFO - Contents: 07:37:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:37:37 INFO - Running post-action listener: _resource_record_post_action 07:37:37 INFO - Running post-action listener: set_extra_try_arguments 07:37:37 INFO - ##### 07:37:37 INFO - ##### Running populate-webroot step. 07:37:37 INFO - ##### 07:37:37 INFO - Running pre-action listener: _resource_record_pre_action 07:37:37 INFO - Running main action method: populate_webroot 07:37:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:37 INFO - '--tppagecycles', 07:37:37 INFO - '7'], 07:37:37 INFO - 'tests': ['tsvgm']}}, 07:37:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['damp', 'tps']}, 07:37:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'tests': ['damp', 'tps']}, 07:37:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['dromaeo_dom']}, 07:37:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['a11yr', 07:37:37 INFO - 'ts_paint', 07:37:37 INFO - 'tpaint', 07:37:37 INFO - 'sessionrestore', 07:37:37 INFO - 'sessionrestore_no_auto_restore', 07:37:37 INFO - 'tabpaint']}, 07:37:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['tsvgx', 07:37:37 INFO - 'tsvgr_opacity', 07:37:37 INFO - 'tart', 07:37:37 INFO - 'tscrollx', 07:37:37 INFO - 'cart']}, 07:37:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:37 INFO - 'tsvgr_opacity', 07:37:37 INFO - 'tart', 07:37:37 INFO - 'tscrollx', 07:37:37 INFO - 'cart']}, 07:37:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'talos_options': ['--disable-e10s'], 07:37:37 INFO - 'tests': ['tp5o']}, 07:37:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'tests': ['tp5o']}, 07:37:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'talos_options': ['--disable-e10s', 07:37:37 INFO - '--xperf_path', 07:37:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:37 INFO - 'tests': ['tp5n']}, 07:37:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:37 INFO - 'talos_options': ['--xperf_path', 07:37:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:37 INFO - 'tests': ['tp5n']}}, 07:37:37 INFO - 'talos.zip': {'path': '', 07:37:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:37 INFO - Running post-action listener: _resource_record_post_action 07:37:37 INFO - ##### 07:37:37 INFO - ##### Running create-virtualenv step. 07:37:37 INFO - ##### 07:37:37 INFO - Running pre-action listener: _resource_record_pre_action 07:37:37 INFO - Running main action method: create_virtualenv 07:37:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:37:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:37 INFO - Using real prefix '/usr' 07:37:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:39 INFO - Installing pip.................done. 07:37:39 INFO - Return code: 0 07:37:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:37:39 INFO - Using env: {'DISPLAY': ':0', 07:37:39 INFO - 'HOME': '/home/cltbld', 07:37:39 INFO - 'LANG': 'en_US.UTF-8', 07:37:39 INFO - 'LANGUAGE': 'en_US:en', 07:37:39 INFO - 'LOGNAME': 'cltbld', 07:37:39 INFO - 'MAIL': '/var/mail/cltbld', 07:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:39 INFO - 'MOZ_NO_REMOTE': '1', 07:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:39 INFO - 'NO_EM_RESTART': '1', 07:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:39 INFO - 'PWD': '/builds/slave/test', 07:37:39 INFO - 'SHELL': '/bin/bash', 07:37:39 INFO - 'SHLVL': '1', 07:37:39 INFO - 'TERM': 'linux', 07:37:39 INFO - 'TMOUT': '86400', 07:37:39 INFO - 'USER': 'cltbld', 07:37:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:39 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:37:40 INFO - Cleaning up... 07:37:40 INFO - Return code: 0 07:37:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', '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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:37: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 psutil>=0.7.1 07:37:40 INFO - Using env: {'DISPLAY': ':0', 07:37:40 INFO - 'HOME': '/home/cltbld', 07:37:40 INFO - 'LANG': 'en_US.UTF-8', 07:37:40 INFO - 'LANGUAGE': 'en_US:en', 07:37:40 INFO - 'LOGNAME': 'cltbld', 07:37:40 INFO - 'MAIL': '/var/mail/cltbld', 07:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:40 INFO - 'MOZ_NO_REMOTE': '1', 07:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:40 INFO - 'NO_EM_RESTART': '1', 07:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:40 INFO - 'PWD': '/builds/slave/test', 07:37:40 INFO - 'SHELL': '/bin/bash', 07:37:40 INFO - 'SHLVL': '1', 07:37:40 INFO - 'TERM': 'linux', 07:37:40 INFO - 'TMOUT': '86400', 07:37:40 INFO - 'USER': 'cltbld', 07:37:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:40 INFO - '_': '/tools/buildbot/bin/python'} 07:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:40 INFO - Downloading/unpacking psutil>=0.7.1 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:42 INFO - Installing collected packages: psutil 07:37:42 INFO - Running setup.py install for psutil 07:37:42 INFO - building 'psutil._psutil_linux' extension 07:37:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:37:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:37:42 INFO - building 'psutil._psutil_posix' extension 07:37:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:37:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:42 INFO - Successfully installed psutil 07:37:42 INFO - Cleaning up... 07:37:42 INFO - Return code: 0 07:37:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', '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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:37: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 mozsystemmonitor==0.0.0 07:37:42 INFO - Using env: {'DISPLAY': ':0', 07:37:42 INFO - 'HOME': '/home/cltbld', 07:37:42 INFO - 'LANG': 'en_US.UTF-8', 07:37:42 INFO - 'LANGUAGE': 'en_US:en', 07:37:42 INFO - 'LOGNAME': 'cltbld', 07:37:42 INFO - 'MAIL': '/var/mail/cltbld', 07:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:42 INFO - 'MOZ_NO_REMOTE': '1', 07:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:42 INFO - 'NO_EM_RESTART': '1', 07:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:42 INFO - 'PWD': '/builds/slave/test', 07:37:42 INFO - 'SHELL': '/bin/bash', 07:37:42 INFO - 'SHLVL': '1', 07:37:42 INFO - 'TERM': 'linux', 07:37:42 INFO - 'TMOUT': '86400', 07:37:42 INFO - 'USER': 'cltbld', 07:37:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:42 INFO - '_': '/tools/buildbot/bin/python'} 07:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:37:44 INFO - Installing collected packages: mozsystemmonitor 07:37:44 INFO - Running setup.py install for mozsystemmonitor 07:37:44 INFO - Successfully installed mozsystemmonitor 07:37:44 INFO - Cleaning up... 07:37:45 INFO - Return code: 0 07:37:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:37:45 INFO - Using env: {'DISPLAY': ':0', 07:37:45 INFO - 'HOME': '/home/cltbld', 07:37:45 INFO - 'LANG': 'en_US.UTF-8', 07:37:45 INFO - 'LANGUAGE': 'en_US:en', 07:37:45 INFO - 'LOGNAME': 'cltbld', 07:37:45 INFO - 'MAIL': '/var/mail/cltbld', 07:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:45 INFO - 'MOZ_NO_REMOTE': '1', 07:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:45 INFO - 'NO_EM_RESTART': '1', 07:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:45 INFO - 'PWD': '/builds/slave/test', 07:37:45 INFO - 'SHELL': '/bin/bash', 07:37:45 INFO - 'SHLVL': '1', 07:37:45 INFO - 'TERM': 'linux', 07:37:45 INFO - 'TMOUT': '86400', 07:37:45 INFO - 'USER': 'cltbld', 07:37:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:45 INFO - '_': '/tools/buildbot/bin/python'} 07:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:47 INFO - Downloading docopt-0.6.1.tar.gz 07:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:47 INFO - Running setup.py install for blobuploader 07:37:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:47 INFO - Running setup.py install for requests 07:37:48 INFO - Running setup.py install for docopt 07:37:48 INFO - Successfully installed blobuploader requests docopt 07:37:48 INFO - Cleaning up... 07:37:48 INFO - Return code: 0 07:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:48 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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:48 INFO - Using env: {'DISPLAY': ':0', 07:37:48 INFO - 'HOME': '/home/cltbld', 07:37:48 INFO - 'LANG': 'en_US.UTF-8', 07:37:48 INFO - 'LANGUAGE': 'en_US:en', 07:37:48 INFO - 'LOGNAME': 'cltbld', 07:37:48 INFO - 'MAIL': '/var/mail/cltbld', 07:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:48 INFO - 'MOZ_NO_REMOTE': '1', 07:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:48 INFO - 'NO_EM_RESTART': '1', 07:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:48 INFO - 'PWD': '/builds/slave/test', 07:37:48 INFO - 'SHELL': '/bin/bash', 07:37:48 INFO - 'SHLVL': '1', 07:37:48 INFO - 'TERM': 'linux', 07:37:48 INFO - 'TMOUT': '86400', 07:37:48 INFO - 'USER': 'cltbld', 07:37:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:48 INFO - '_': '/tools/buildbot/bin/python'} 07:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:48 INFO - Running setup.py (path:/tmp/pip-3_9FDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:48 INFO - Running setup.py (path:/tmp/pip-DZm6OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:48 INFO - Running setup.py (path:/tmp/pip-TZewCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:48 INFO - Running setup.py (path:/tmp/pip-dA3ukY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:48 INFO - Running setup.py (path:/tmp/pip-ghEy4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:49 INFO - Running setup.py (path:/tmp/pip-v_Nfyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:49 INFO - Running setup.py (path:/tmp/pip-2V_UZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:49 INFO - Running setup.py (path:/tmp/pip-gS8YV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:49 INFO - Running setup.py (path:/tmp/pip-QymmKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:49 INFO - Running setup.py (path:/tmp/pip-Z7c6Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:49 INFO - Running setup.py (path:/tmp/pip-ltaQIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:49 INFO - Running setup.py (path:/tmp/pip-ciJupK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:49 INFO - Running setup.py (path:/tmp/pip-OMNZ4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:49 INFO - Running setup.py (path:/tmp/pip-iOu7yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:49 INFO - Running setup.py (path:/tmp/pip-ouQiAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:49 INFO - Running setup.py (path:/tmp/pip-Os3pPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:49 INFO - Running setup.py (path:/tmp/pip-J4V1uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:49 INFO - Running setup.py install for manifestparser 07:37:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozcrash 07:37:50 INFO - Running setup.py install for mozdebug 07:37:50 INFO - Running setup.py install for mozdevice 07:37:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozfile 07:37:50 INFO - Running setup.py install for mozhttpd 07:37:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozinfo 07:37:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozInstall 07:37:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for mozleak 07:37:50 INFO - Running setup.py install for mozlog 07:37:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:50 INFO - Running setup.py install for moznetwork 07:37:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Running setup.py install for mozprocess 07:37:51 INFO - Running setup.py install for mozprofile 07:37:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Running setup.py install for mozrunner 07:37:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Running setup.py install for mozscreenshot 07:37:51 INFO - Running setup.py install for moztest 07:37:51 INFO - Running setup.py install for mozversion 07:37:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:51 INFO - Cleaning up... 07:37:51 INFO - Return code: 0 07:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:51 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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:51 INFO - Using env: {'DISPLAY': ':0', 07:37:51 INFO - 'HOME': '/home/cltbld', 07:37:51 INFO - 'LANG': 'en_US.UTF-8', 07:37:51 INFO - 'LANGUAGE': 'en_US:en', 07:37:51 INFO - 'LOGNAME': 'cltbld', 07:37:51 INFO - 'MAIL': '/var/mail/cltbld', 07:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:51 INFO - 'MOZ_NO_REMOTE': '1', 07:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:51 INFO - 'NO_EM_RESTART': '1', 07:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:51 INFO - 'PWD': '/builds/slave/test', 07:37:51 INFO - 'SHELL': '/bin/bash', 07:37:51 INFO - 'SHLVL': '1', 07:37:51 INFO - 'TERM': 'linux', 07:37:51 INFO - 'TMOUT': '86400', 07:37:51 INFO - 'USER': 'cltbld', 07:37:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:51 INFO - '_': '/tools/buildbot/bin/python'} 07:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:51 INFO - Running setup.py (path:/tmp/pip-o3ji2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:52 INFO - Running setup.py (path:/tmp/pip-ONY4cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:52 INFO - Running setup.py (path:/tmp/pip-_w8OGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:52 INFO - Running setup.py (path:/tmp/pip-S7e0gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:52 INFO - Running setup.py (path:/tmp/pip-I7Fz7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:52 INFO - Running setup.py (path:/tmp/pip-Zx188h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:52 INFO - Running setup.py (path:/tmp/pip-bNZhM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:52 INFO - Running setup.py (path:/tmp/pip-O8F3AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:52 INFO - Running setup.py (path:/tmp/pip-fdk5LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:52 INFO - Running setup.py (path:/tmp/pip-TJuGW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:52 INFO - Running setup.py (path:/tmp/pip-eqpMDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:52 INFO - Running setup.py (path:/tmp/pip-DR8vjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:52 INFO - Running setup.py (path:/tmp/pip-ciIYI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:52 INFO - Running setup.py (path:/tmp/pip-OxvTW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:52 INFO - Running setup.py (path:/tmp/pip-wcB7ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:53 INFO - Running setup.py (path:/tmp/pip-NeqmJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:53 INFO - Running setup.py (path:/tmp/pip-Qr1H1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:55 INFO - Downloading blessings-1.6.tar.gz 07:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:55 INFO - Installing collected packages: blessings 07:37:55 INFO - Running setup.py install for blessings 07:37:55 INFO - Successfully installed blessings 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:55 INFO - Reading from file tmpfile_stdout 07:37:55 INFO - Current package versions: 07:37:55 INFO - argparse == 1.2.1 07:37:55 INFO - blessings == 1.6 07:37:55 INFO - blobuploader == 1.2.4 07:37:55 INFO - docopt == 0.6.1 07:37:55 INFO - manifestparser == 1.1 07:37:55 INFO - mozInstall == 1.12 07:37:55 INFO - mozcrash == 0.17 07:37:55 INFO - mozdebug == 0.1 07:37:55 INFO - mozdevice == 0.48 07:37:55 INFO - mozfile == 1.2 07:37:55 INFO - mozhttpd == 0.7 07:37:55 INFO - mozinfo == 0.9 07:37:55 INFO - mozleak == 0.1 07:37:55 INFO - mozlog == 3.1 07:37:55 INFO - moznetwork == 0.27 07:37:55 INFO - mozprocess == 0.22 07:37:55 INFO - mozprofile == 0.28 07:37:55 INFO - mozrunner == 6.11 07:37:55 INFO - mozscreenshot == 0.1 07:37:55 INFO - mozsystemmonitor == 0.0 07:37:55 INFO - moztest == 0.7 07:37:55 INFO - mozversion == 1.4 07:37:55 INFO - psutil == 3.1.1 07:37:55 INFO - requests == 1.2.3 07:37:55 INFO - wsgiref == 0.1.2 07:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:37:55 INFO - Using env: {'DISPLAY': ':0', 07:37:55 INFO - 'HOME': '/home/cltbld', 07:37:55 INFO - 'LANG': 'en_US.UTF-8', 07:37:55 INFO - 'LANGUAGE': 'en_US:en', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MAIL': '/var/mail/cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SHLVL': '1', 07:37:55 INFO - 'TERM': 'linux', 07:37:55 INFO - 'TMOUT': '86400', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - '_': '/tools/buildbot/bin/python'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37: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', 'jsonschema'] in /builds/slave/test/build 07:37: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 jsonschema 07:37:55 INFO - Using env: {'DISPLAY': ':0', 07:37:55 INFO - 'HOME': '/home/cltbld', 07:37:55 INFO - 'LANG': 'en_US.UTF-8', 07:37:55 INFO - 'LANGUAGE': 'en_US:en', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MAIL': '/var/mail/cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SHLVL': '1', 07:37:55 INFO - 'TERM': 'linux', 07:37:55 INFO - 'TMOUT': '86400', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - '_': '/tools/buildbot/bin/python'} 07:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:55 INFO - Downloading/unpacking jsonschema 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:57 INFO - Downloading/unpacking functools32 (from jsonschema) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:58 INFO - warning: no files found matching '*.txt' 07:37:58 INFO - no previously-included directories found matching 'build' 07:37:58 INFO - no previously-included directories found matching 'dist' 07:37:58 INFO - no previously-included directories found matching '.git*' 07:37:58 INFO - Installing collected packages: jsonschema, functools32 07:37:58 INFO - Running setup.py install for functools32 07:37:58 INFO - warning: no files found matching '*.txt' 07:37:58 INFO - no previously-included directories found matching 'build' 07:37:58 INFO - no previously-included directories found matching 'dist' 07:37:58 INFO - no previously-included directories found matching '.git*' 07:37:58 INFO - Successfully installed jsonschema functools32 07:37:58 INFO - Cleaning up... 07:37:58 INFO - Return code: 0 07:37:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:58 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 0x7fc3ccdf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14555a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:37:58 INFO - Using env: {'DISPLAY': ':0', 07:37:58 INFO - 'HOME': '/home/cltbld', 07:37:58 INFO - 'LANG': 'en_US.UTF-8', 07:37:58 INFO - 'LANGUAGE': 'en_US:en', 07:37:58 INFO - 'LOGNAME': 'cltbld', 07:37:58 INFO - 'MAIL': '/var/mail/cltbld', 07:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:58 INFO - 'MOZ_NO_REMOTE': '1', 07:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:58 INFO - 'NO_EM_RESTART': '1', 07:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:58 INFO - 'PWD': '/builds/slave/test', 07:37:58 INFO - 'SHELL': '/bin/bash', 07:37:58 INFO - 'SHLVL': '1', 07:37:58 INFO - 'TERM': 'linux', 07:37:58 INFO - 'TMOUT': '86400', 07:37:58 INFO - 'USER': 'cltbld', 07:37:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:58 INFO - '_': '/tools/buildbot/bin/python'} 07:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:58 INFO - Downloading/unpacking flake8 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:01 INFO - no previously-included directories found matching 'docs/_build' 07:38:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:01 INFO - Running setup.py install for pep8 07:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:01 INFO - no previously-included directories found matching 'docs/_build' 07:38:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:01 INFO - Cleaning up... 07:38:01 INFO - Return code: 0 07:38:01 INFO - Running post-action listener: _resource_record_post_action 07:38:01 INFO - Running post-action listener: _start_resource_monitoring 07:38:01 INFO - Starting resource monitoring. 07:38:01 INFO - ##### 07:38:01 INFO - ##### Running install step. 07:38:01 INFO - ##### 07:38:01 INFO - Running pre-action listener: _resource_record_pre_action 07:38:01 INFO - Running main action method: install 07:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:01 INFO - Reading from file tmpfile_stdout 07:38:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:01 INFO - Reading from file tmpfile_stdout 07:38:01 INFO - Output received: 07:38:01 INFO - Usage: mozinstall [options] installer 07:38:01 INFO - Options: 07:38:01 INFO - -h, --help show this help message and exit 07:38:01 INFO - -d DEST, --destination=DEST 07:38:01 INFO - Directory to install application into. [default: 07:38:01 INFO - "/builds/slave/test"] 07:38:01 INFO - --app=APP Application being installed. [default: firefox] 07:38:01 INFO - mkdir: /builds/slave/test/build/application 07:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:18 INFO - Reading from file tmpfile_stdout 07:38:18 INFO - Output received: 07:38:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:18 INFO - Running post-action listener: _resource_record_post_action 07:38:18 INFO - ##### 07:38:18 INFO - ##### Running run-tests step. 07:38:18 INFO - ##### 07:38:18 INFO - Running pre-action listener: _resource_record_pre_action 07:38:18 INFO - Running main action method: run_tests 07:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:18 INFO - Python 2.7.3 07:38:18 INFO - Return code: 0 07:38:18 INFO - grabbing minidump binary from tooltool 07:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:18 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 0x14e4410>, '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 0x14e5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:38:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:38:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:18 INFO - Return code: 0 07:38:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:38:19 INFO - Return code: 0 07:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:38:19 INFO - Using env: {'DISPLAY': ':0', 07:38:19 INFO - 'HOME': '/home/cltbld', 07:38:19 INFO - 'LANG': 'en_US.UTF-8', 07:38:19 INFO - 'LANGUAGE': 'en_US:en', 07:38:19 INFO - 'LOGNAME': 'cltbld', 07:38:19 INFO - 'MAIL': '/var/mail/cltbld', 07:38:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:19 INFO - 'MOZ_NO_REMOTE': '1', 07:38:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:19 INFO - 'NO_EM_RESTART': '1', 07:38:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:19 INFO - 'PWD': '/builds/slave/test', 07:38:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:19 INFO - 'SHELL': '/bin/bash', 07:38:19 INFO - 'SHLVL': '1', 07:38:19 INFO - 'TERM': 'linux', 07:38:19 INFO - 'TMOUT': '86400', 07:38:19 INFO - 'USER': 'cltbld', 07:38:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166', 07:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:19 INFO - '_': '/tools/buildbot/bin/python'} 07:38:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:38:19 INFO - mozversion application_buildid: 20160414043111 07:38:19 INFO - mozversion application_changeset: 55b6f17f513ceadf145c8b0600ab06a68c55cf34 07:38:19 INFO - mozversion application_display_name: Nightly 07:38:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:19 INFO - mozversion application_name: Firefox 07:38:19 INFO - mozversion application_remotingname: firefox 07:38:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:38:19 INFO - mozversion application_vendor: Mozilla 07:38:19 INFO - mozversion application_version: 48.0a1 07:38:19 INFO - mozversion platform_buildid: 20160414043111 07:38:19 INFO - mozversion platform_changeset: 55b6f17f513ceadf145c8b0600ab06a68c55cf34 07:38:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:38:19 INFO - mozversion platform_version: 48.0a1 07:38:19 INFO - using testdate: 1460644699 07:38:19 INFO - actual date: 1460644699 07:38:19 INFO - starting webserver on 'localhost:59886' 07:38:19 INFO - SUITE-START | Running 2 tests 07:38:19 INFO - TEST-START | dromaeo_css 07:38:19 INFO - operating with platform_type : linux_ 07:38:19 INFO - Initialising browser for dromaeo_css test... 07:38:19 INFO - TEST-INFO | started process 1776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpClHT6y/profile http://localhost:59886/getInfo.html) 07:38:23 INFO - PROCESS | 1776 | 07:38:23 INFO - PROCESS | 1776 | (process:1843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:38:23 INFO - PROCESS | 1776 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:38:24 INFO - PROCESS | 1776 | __metrics Screen width/height:1600/1200 07:38:24 INFO - PROCESS | 1776 | colorDepth:24 07:38:24 INFO - PROCESS | 1776 | Browser inner width/height: 1024/697 07:38:24 INFO - PROCESS | 1776 | __metrics 07:38:24 ERROR - PROCESS | 1776 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:38:25 INFO - TEST-INFO | 1776: exit 0 07:38:25 INFO - Browser initialized. 07:38:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:25 INFO - TEST-INFO | started process 1894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpClHT6y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:27 INFO - PROCESS | 1894 | 07:38:27 INFO - PROCESS | 1894 | (process:1954): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:38:37 INFO - PROCESS | 1894 | RSS: Main: 163176448 07:38:37 INFO - PROCESS | 1894 | 07:39:27 INFO - PROCESS | 1894 | 1460644767236 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:41:35 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59886/tests/dromaeo/cssquery-ext.html) 07:41:36 INFO - PROCESS | 1894 | RSS: Main: 168296448 07:41:36 INFO - PROCESS | 1894 | 07:44:38 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-ext.html (next: http://localhost:59886/tests/dromaeo/cssquery-jquery.html) 07:44:38 INFO - PROCESS | 1894 | RSS: Main: 165687296 07:44:38 INFO - PROCESS | 1894 | 07:47:40 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59886/tests/dromaeo/cssquery-mootools.html) 07:47:41 INFO - PROCESS | 1894 | RSS: Main: 166227968 07:47:41 INFO - PROCESS | 1894 | 07:50:42 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59886/tests/dromaeo/cssquery-prototype.html) 07:50:43 INFO - PROCESS | 1894 | RSS: Main: 163790848 07:50:43 INFO - PROCESS | 1894 | 07:53:45 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59886/tests/dromaeo/cssquery-yui.html) 07:53:46 INFO - PROCESS | 1894 | RSS: Main: 165335040 07:53:46 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:59886/tests/dromaeo/cssquery-yui.html (next: http://localhost:59886/tests/dromaeo/cssquery-dojo.html) 07:56:48 INFO - PROCESS | 1894 | RSS: Main: 167530496 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | __start_tp_report 07:56:48 INFO - PROCESS | 1894 | _x_x_mozilla_page_load 07:56:48 INFO - PROCESS | 1894 | _x_x_mozilla_page_load_details 07:56:48 INFO - PROCESS | 1894 | |i|pagename|runs| 07:56:48 INFO - PROCESS | 1894 | |0;dojo.html;3053.5114381698927;3145.4809956357203;3154.2587491939385;3167.5723777290086;3192.3455691583226;5381.677099374036;5382.838514844556;5387.595930305228;5450.890982180354;5497.47773961474;5298.36419629644;5376.193570964358;5453.836384908459;5467.152591348347;5469.398366179727;4859.076775412669;4876.195427754416;4930.161872481669;4947.109520286347;4995.550400463958;4927.704337739729;4945.579625731817;4991.500849914997;5008.474110218429;5059.924101138467;4807.78364973577;4836.54052864979;4871.171900776876;4875.195592727196;4889;4876.439209490918;4888.095702295087;4892.8532144035735;4916.508349165055;4950.232713929347;4842.830500932486;4865.805367785284;4877.317175595419;4884.438289596706;4899.975500122512;5237.79048838046;5291.259223708646;5307.416184219733;5307.787688492455;5320.733963301858;5720.799772008001;5726.026575482178;5736.426357364272;5754.539636829044;5756.079027355603;5632.633878797906;5784.710764461802;5798.42015798421;5799.420057994209;5883.441073098049;5410.404855465896;5414.160805075219;5415.296011518517;5423.2407462954825;5473.452654734535;5861.296644402699;5886;5925.259342582177;5942.316633587193;5948.226730525091;5501.669899806025;5616.494515493625;5675.120356344773;5693.516051135617;5703.429657034263;5781.653100813965;5799.623024503394;5800.796972105956;5802.796902108406;5857.47282744555;5668.461496157858;5745;5774.220480235199;5783.971080144573;5802.042662960649;5597.74810133545;5683.175939488834;5738.368779434259;5743.425657434307;5757.424257574209;4256.787160642018;4271.209826182104;4277.123189746095;4316.330968699856;4333;3877.0307423144213;3887.611238876146;3892.3188442023097;3912.68698504119;3918.040080180374;5231.24146998683;5456.372517160577;5462.426445223195;5506.256655351556;5517.5585953123655;5851.239338885917;5855.297364316224;5863.501602363762;5873.060310350324;5890.7938222162875;5458.263134476874;5462.126059830408;5482.23248745176;5501.614886957955;5502.449755024466;4668.043051174501;4785.186518291829;4812.687175333662;4858.7570621469495;4868.172410690191;6019.578629495893;6042.154098426224;6055.2128223331565;6060.757569697251;6079.939200608026;5874.324452687995;5878.588498805128;5880.941190588211;5886.05823068307;5901.173835662925;5926.970365148319;5933.614315069507;6022.759089636365;6077.301110372364;6093.75624974996;5686.886262274814;5705.286839145107;5719.399463056319;5746.482816546531;5757.3379061406795;5802.1296805479515;5806.187133801355;5854.765809367577;5854.853628659318;5855.00464920956;5507.504324610804;5530.142827861688;5593.384727679871;5657.547396208376;5710.65736055838;5696.231008813757;5737.56968227393;5741.224934633938;5759.65442073477;5809.477147056785;5558.694271815089;5577.972110139423;5599.32808063035;5601.271834661468;5603.887922241451;5510.752016159202;5527.198556209408;5633.971830140823;5671.404502527175;5713.771449141987;5560.666360018412;5580.107182850725;5586.916196256978;5588.692621905834;5590.636608620427 07:56:48 INFO - PROCESS | 1894 | |1;ext.html;625.5777350288557;653.5719103986888;662.8541720821421;678.4979115454563;690.4752388184984;37035.25929481409;38631.420528692055;38650.61349386505;38658.61341386585;38928;39340.80329598348;39374;39537.40693889594;39745.403818942665;39804;8335.041470230924;8547.529885856307;8563.700270490534;8617.526036068013;8634.093420190884;8416.537090460022;8581.957090214572;8593.613287402051;8596.312295016414;8835.293176545892;8738.606762695694;8767.56162191891;8802.207801297882;8813.338999575057;8836.911630883706;8706.956465217696;8770.912290877106;8774.868376974351;8796.956015219883;8799.868001979976;8766.21104100634;8856.468611883243;8869.55652217393;8871.733847984571;8882.333824963154;30859.691403085908;39392;39850;39959.60040399588;39967;3382.2072518327673;3489.8778542750883;3599.262151258986;3816.9045773855596;3992.0818211811156;26286.6057009145;26869.462610747676;27110.32224194391;27584.310392240153;28934.85532572345;4051.3517837145914;4099.3031184698375;4183.769892655902;4185.895352616209;4186.204621121977;237857;238093;238107;238569;240170.7991460049;33717.494237586456;34404.13989650229;34431.827840860635;35443.4683479748;36449.453258201145;34058.48912266318;34153.829230854186;34180.48729269063;34257.143571410415;34268.65731342655;14812.333444995002;15064.32210550506;15098.320575574126;15111.773323400157;15130.167840768643;12485.56300529477;12579.119461637598;12589.622311330675;12590.874091259153;12594.81107783384;8450.901382820193;8498.405111642125;8518.914810851937;8566.400351975302;8624.396292259482;3324.5511855899626;3329.1011426914597;3347.7489188310974;3401.200717831308;3408.9488657670154;1060.226034994443;1068.8289873620338;1083.669480808361;1084.3331351219101;1187.6615164678026;31144.844275778476;31323.373532529222;31781.52327715086;31976;32437.35125297528;1186.887245711656;1193.349624454657;1260.521002019227;1278.341654048166;1309.9148555343872;16297.755533667005;16442.40810228786;16510.17449127539;16796.412125575545;16963.321467141177;460277;465489;468635;469421;470077;54866.451335486134;56019.15971260434;56085;56112.43887561072;56114;1379.2483096712315;1379.8551152129082;1398.6013986013936;1407.1486750515994;1424.0956992309957;28961.56557651679;29454.558181626864;29518.262043448227;29584.556231656974;30391.240218994702;49477;49788.02119787992;50049.49950500448;50089.49910500849;50093.49906500888;402811;408270;408475;410050;410725;27204.863975679997;27305.85982612025;27632.723672763015;27690.44619107647;27703;45992.54007459882;46248.537514624426;46264;46935;46984.29523557081;38998.41502377523;39057.80471097626;39748.60251397449;39896.401553977295;40002.1999560013;37684.05789855166;39226;39484.60515394809;40399.39400909047;40714.59285407227;35669.643303566634;41228.58771412368;41528.79235603803;42074.36888446737;42869.356959645;33496.83251583727;33579;33856;33998.66001339955;34408.82795586006;26436.206913792616;27123.86438067876;27153;27167.86416067986;27302 07:56:48 INFO - PROCESS | 1894 | |2;jquery.html;382.29275839696567;388.3669618521809;398.7627361719777;400.35742633073914;401.5081525131714;17939.55151121221;18414.539636509093;18544.07279636018;18554.90722546389;20068.39794806158;18797.906010469927;18888;19184.904075479604;19689.803101968977;19702.802971970275;5529.806456774014;5576.442355764431;5751.683657398841;5763.106718458645;5770.480656740892;5609.607327487057;5629.831105066834;5629.943700563003;5632.859178520529;5646.915296270559;5374.140137577989;5608.43915608438;5666.716664166795;5667.914981275284;5710.628809127415;5634.154876768476;5666.235058267122;5674.779922316701;5678.318601767773;5679.744411501492;4787.521247875219;5025.623078269145;5048.671836330626;5053.444121146671;5071.949280507185;21889.12443502258;21931;22789.31632051041;22828.086876524918;22963.88518057399;2307.3654744945106;2446.204983380391;2476.777090061903;2724.577690457982;2816.436712657456;14672.853271467255;15253.771193432107;15681.137537435436;15742.291596878167;16140.35438582467;2022.8280596149345;2068.7103805467245;2098.790120987904;2100.926467573643;2271.8409711320214;89941;91068.99999999933;93909.53045234799;94483;94496.52751736266;16853.494395168163;17049.7442538362;17154.485365438806;17617.735733964;17658.646827063385;31177.8441107793;31359.37281254362;31418.37163256722;31713.04860854178;31768;10097.848532272023;10305.74235644115;10366.118879895294;10423.426711530787;10577.894221057844;8725.869111963326;8736.301095912311;8816.647334106692;8834.64661413549;8896.955515222511;8797.252233560092;8857.29141668665;8931.553422328858;8980.955095224483;8995;3390.1524618845287;3511.17487390463;3535.1869070114017;3561.4479755637917;3563.2813667380897;939.33307351781;1022.1465076660922;1037.984430233547;1064.2762921213493;1076.1283360478037;17808.55478613045;18708.625827483374;18898.81101188998;18944.52638684044;18997.62004759897;1005.5776573838859;1008.6419321141036;1031.138998935882;1052.4632437456798;1074.8387741838787;8383.832323353621;10600;10658.626948056935;10706.785864282827;10934.671959841218;445998;449425;450140;451417;454462;89793.10206897979;91338;92280.53859730659;93291;93782;1048.8584041154347;1060.5545670818274;1071.9839202411813;1072;1077.06833588945;16290.755638665667;16564.83435165633;16663.250153743353;16803.41188058412;16936.322547097978;36884.81557592195;37935.81032094822;37959.620403795605;38060.42909356306;38781.41827872528;52082;55443.445565545444;55488.167677485675;55682.44317556773;56989.43010570007;7183.102112235971;7427.5914824683;8173.632186551738;8343.95828020856;8641.524716140673;12106.636800895987;12383.19509231897;12530.812037819622;12579.308138052129;12835.165714228919;11270.492827822603;11554.884451155716;11580.478878450322;11612.361320127475;11628.476718547854;11246.775064498828;11483.36841473727;11498.770024599295;11528.82706759416;11598.594049208237;11743.530258789553;11769;11775.293482391084;11835.171537992257;11924.463399146885;7623.542587444771;7696.560655492651;7703.383729301754;7757;7902.762917112495;11441.656750297505;11657.300561966309;11745.882541174478;11800.055995520166;11855.940720296343 07:56:48 INFO - PROCESS | 1894 | |3;mootools.html;1507.17858766972;1558.51685977347;1713.8885972411792;1797.4338083503687;1842.797292297847;7134.8573028539395;8062.798430039252;8096.91903080969;8354.289885359753;8361.414700970927;8097.1902809718995;8148.877766833488;8214.548199849007;8231.711890083849;8246.95876520618;2313.144136669435;2337.2053501809382;2340.4499942513494;2343.16817529777;2350.236173243694;2223.2440970070174;2275.1468199425217;2325.4883925536355;2336.19401306549;2337.333859849943;2274.6815445837597;2316.8957396917094;2319.072371051576;2337.637666161748;2359.8938047787806;2187.9562408751817;2190.485235969546;2198.0548364203387;2199.7800219978035;2227.098025299756;2282.7717228277206;2285.908563657452;2298.425393651587;2299.1722979727283;2300.815934725218;8292;8412.411131220817;8418.536980466071;8427.873581896276;8429.915700843036;5025.874353141201;5225.895482090337;5238.895222095575;5240.056789777838;5274.077036518594;3279;3291.325278317939;3371.9662803372144;3390.9152271193416;3403.897883063512;1143.2511704833348;1148.1561052626314;1149.7987852125846;1165.626999360205;1175.7883580955424;11204.383758893258;11211.943940280247;11220.551177952872;11331.943340283246;11332.886671133183;4410.29435290352;4556.498785133699;4745.1221524018165;4751.881202969884;4777.689450185727;8918.24194943437;8998.775030624287;9047.864282035775;9072.682456114137;9081.273498120134;5089.770960306795;5105.744712764421;5110.923336149961;5142.074426603247;5198.32421785173;4161.292580261363;4674.976625116853;4777.617790576745;4793.664443488922;4845.394325709286;3645.908852278661;3649.872254471134;3726.3851464508593;3736.3834967230646;3777.395616701315;1119.1494464207099;1136.9488373023235;1142.845715828369;1146.2606618730872;1147.2886810177577;984.6799790068256;1030.4229631406436;1038.85456036155;1043.186314674555;1043.9373637581768;5707.6290041147195;5811;5853.239078919798;5859.589828712034;6004.789832355847;878.2315473960285;919.5540163020929;974.9220062394992;993.1607791416242;1006.8238058339762;4119.299719047769;4232.746035237896;4258.936115958263;4279.614834664895;4303.462067241595;9819.754506137404;10050.497475126214;10154.339967902211;10158.847617285746;10161.593536258615;9682.370645907993;9975.401475911469;10100;10122.645707400206;10319.380837149794;7777.416693747991;7870.409719270963;7891.28978391936;7931.286184243446;8011.038675358877;5537.861553461034;5607.355154157324;5674.687892165971;5702.5437964961875;5745.511631511368;9359.15767580921;9437.339386242897;9443.95278023633;9565.617375305188;9594.808103838024;9324.627014919328;9462.337636365664;9717.708468745948;9730.464824434725;9877.259205559756;6541.443977261986;7102;7209.855802883808;7386.889196661947;7422.183559808309;7952.284294413531;7960.044794624682;7976.401769867167;7986.081600616004;8012;6996.090508233897;7343.889841652486;7359.668814903235;7387.630618469163;7443.888341674988;7082.079329687108;7112.146542414736;7124.109486314211;7140.7857764267155;7195.568265904062;6852.657367131723;6961.756338528127;6973.12835895513;6974.930250697428;7001.054857594363;4845.491223421631;4961.454240033521;4967.850964471072;4970.801167953241;5030.270610761492;5065.341505604248;5065.772040258271;5100.413452452867;5190.740462976761;5201.6098792591465 07:56:48 INFO - PROCESS | 1894 | |4;prototype.html;329.0917068889865;333.57302652604665;337.9932401351975;339.3078120633907;342.1736506337196;5903.734331955062;6000.7299671514775;6019.939800601993;6023.759049638009;6035.426634469729;5966.164736936832;5974.817627660644;5981.342052374235;5988.700564971756;5989.071693887455;4307.892302692434;4409.536998615147;4530.482288433363;4540.772961351936;4550.180967425862;4503.414556107701;4537.636989040885;4546.568076032771;4549.727016379028;4555.703879247838;4515.480719717241;4524.389207456984;4553.317002449642;4554.4990051094355;4561.498235194143;4270.615644591986;4479.193745125876;4483.574060464251;4487.820487180509;4506.053728716974;3845.5193100862393;3861.498005259298;3885.805709714503;3890.513685789276;3890.657723085531;5711.143328500717;5747.281589801275;5768.3366412862215;5779.1620215069;5793.362730099686;5083.415407228179;5203.126874325239;5207.583393328525;5226.451222621608;5255.610131465183;6224.377562243784;6294.7482100715915;6295.433410992987;6297.275813281485;6310.0850376695125;4203.516595591515;4335.826566937319;4340.350666746616;4342.2401079811225;4354.129174165179;6564.277929427759;6626.469882409396;6635.170603674541;6638.900416493708;6643.468522518236;4363.3018717005125;4365;4373.081652852937;4378.5183629800695;4384.693071484965;4341.565843415633;4447.555244475527;4457.910841783146;4464.575865292857;4482.910341793146;5166.354205724285;5167.896642067213;5181.740912954338;5184.429712731597;5202.4277329493725;6275.3724627537795;6293.811185664437;6301.590396624205;6329.177206963065;6329.3354197809485;1503.4963287298876;1531.8008658874276;1557.1980430078518;1558.534977121525;1565.2877940537028;961.1397798969883;1012.094175712733;1021.9795604087876;1025.2157099818644;1025.5743866295404;5881.235439392937;5958.821235362946;5970.552208584373;6052.757889684452;6056.939430605726;6296.842578935563;6410.781951429213;6453.741850325934;6470.191226096738;6500.739970401226;5791.247137872134;5967.940320596826;5975.7609695612555;5976.103584462366;5998.070299103646;3434.059756237718;3444.225049363873;3492.4237500812587;3498.2478767065204;3506.193575477603;6562.278149403657;6694.552305562639;6764.425023872927;6771.3905748482875;6804.455643548505;6496.317886621931;6528.706208220547;6548.8035358939305;6550;6577.309382514863;6479.222493300834;6683.4987375947;6688.39804417595;6704.765333213314;6722.092517510171;6397.1363865879375;6400.199975003125;6403.64779937108;6438.6136831790245;6448.29068802422;6259.6870156492905;6301.275353334425;6376;6391.169148010729;6418.807435776934;6667.333266673294;6670.166229221348;6742.393184613408;6747.224069232101;6752.628605426552;4409.713368631029;4418.513963463952;4421.513633500248;4422.778861056999;4427.291633338779;6290.150829637941;6449.322821103717;6466.773662921775;6470.611763294218;6477.967610161919;6253.7185826637;6279.466245369012;6289.119523266655;6326.43062124411;6334.778282760081;6224.751009959551;6275.592086514362;6278.309385967631;6293.727261823735;6321.557490975588;5925.1704761332585;6058.333583305921;6066.211392518944;6226.813195604139;6252.687365631791;6443.807895539153;6446.580972236789;6477.643729594917;6480.643564603992;6495.512836537184;6138.631682099089;6158.353372895961;6316.936830631818;6364.554481186457;6376.362363763772 07:56:48 INFO - PROCESS | 1894 | |5;yui.html;734.5555938657111;741.329097167064;798.720447843255;856.8971723393191;857.018713572959;13965.162090274565;14827.851721482783;15170.469033583826;15190.848091519081;15260.771088433668;14073.648158796035;14079.436822527086;14178.50375236867;14228.288585570706;14240.501582444616;823.8064054947098;860.8579584368572;867.4101610904582;867.6659486097866;867.8828358171661;835.2691395029349;838.3921656798833;838.6896848166188;839.353697652807;842.338764070205;884.907084756101;886.1979908183073;887.1439061305839;887.5384799904047;889.2397000564489;866.4411454611771;876.9693060742875;881.0352663833124;881.6385282034399;888.3958907942597;643.3694978920637;648.7145655911384;649.0880313160018;649.1723053107279;653.7090994507446;13225.537106201236;13376.264305463195;13453;13500.39248233822;13513.797293040612;13905.513307034205;13929.721405571832;14022.579322620337;14051.578452646334;14052.36764345607;11636.127290453165;11654.76690466186;11729.88270117305;11751.177417580773;12029.458674359676;3732.9440058399146;3737.794421306854;3822.923541529182;3835.9041023974346;3896.4350169225304;57103;57112;57227.14159287614;57372.139417908766;57773.71113144408;10662.413567253876;10681.626143084955;10687.25189236746;10694.197935154894;10790.136789057013;19151.233950642098;19161.425157245307;19168.13743381551;19170.71243931342;19186;8365;8432.494050356998;8488.236058754619;8498.447600905922;8548.658053677907;4953;5015.573676237488;5048.596112311006;5085.338905942278;5110.948890511122;3411.8805841795916;3484.930301393958;3509.0700964244497;3509.578850537952;3511.754177207622;624.4255285137684;639.0318667219167;639.5395315372924;639.9520035997319;641.4579680170249;741.4179868803071;761.5050217358761;768.6080099149474;775.4726785785607;781.5818537082633;9175.862362064574;9394.248460123174;9400.764980875396;9562.235021198287;9617;734.6216698400328;736.4292673178222;742.985140297191;749.2470067582045;766.2873132483696;4515.209838278354;4525.208088584484;4540.409746732904;4573.199690054227;4665.6967297125575;61085.38914610797;62312;62595.374046259865;62992.370076299565;63089;53107.73446132745;53644;54487;54549;54999;46343;46801;46898.531014690096;47261.29108063382;47738.28392574114;9009.909900900908;9073.410228335137;9299.256059515088;9380.343375963617;9432.151106400457;28841.567376489787;29256.41487170202;29487.705122949355;31224.843875780476;32284.19289517781;34327.31345373028;34606.30787384188;42393.788031059645;42489.36265956075;44038;12467.127301088836;12595.74808503843;12660.556880509139;12715.872841271468;12904.612861614167;13142.671433213864;13377.398017089448;13549.661258468617;13603.591892243248;13961.4415423386;13019.869801302244;13020.47918083266;13058.34708264564;13224.338783061;13727.519536816164;12793.61619151427;13136.605901822579;13193.274369909746;13830.03189776706;13833.723325533232;12808.359582020676;13231.80152297697;13351.265680387283;13354.532591359255;13354.799678004643;10624.468776561296;10857.239993200401;10910.890891091305;11056.668299951014;11470.197086203885;10534.473276336306;10888.836667450152;10950.726231844268;11035.172362073037;11155.944220278847 07:56:48 INFO - PROCESS | 1894 | __end_tp_report 07:56:48 INFO - PROCESS | 1894 | __start_cc_report 07:56:48 INFO - PROCESS | 1894 | _x_x_mozilla_cycle_collect,331 07:56:48 INFO - PROCESS | 1894 | __end_cc_report 07:56:48 INFO - PROCESS | 1894 | __startTimestamp1460645808871__endTimestamp 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | ------- Summary: start ------- 07:56:48 INFO - PROCESS | 1894 | Number of tests: 6 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#0] dojo.html Cycles:165 Average:5363.01 Median:5577.97 stddev:629.42 (11.3%) stddev-sans-first:604.71 07:56:48 INFO - PROCESS | 1894 | Values: 3053.5 3145.5 3154.3 3167.6 3192.3 5381.7 5382.8 5387.6 5450.9 5497.5 5298.4 5376.2 5453.8 5467.2 5469.4 4859.1 4876.2 4930.2 4947.1 4995.6 4927.7 4945.6 4991.5 5008.5 5059.9 4807.8 4836.5 4871.2 4875.2 4889.0 4876.4 4888.1 4892.9 4916.5 4950.2 4842.8 4865.8 4877.3 4884.4 4900.0 5237.8 5291.3 5307.4 5307.8 5320.7 5720.8 5726.0 5736.4 5754.5 5756.1 5632.6 5784.7 5798.4 5799.4 5883.4 5410.4 5414.2 5415.3 5423.2 5473.5 5861.3 5886.0 5925.3 5942.3 5948.2 5501.7 5616.5 5675.1 5693.5 5703.4 5781.7 5799.6 5800.8 5802.8 5857.5 5668.5 5745.0 5774.2 5784.0 5802.0 5597.7 5683.2 5738.4 5743.4 5757.4 4256.8 4271.2 4277.1 4316.3 4333.0 3877.0 3887.6 3892.3 3912.7 3918.0 5231.2 5456.4 5462.4 5506.3 5517.6 5851.2 5855.3 5863.5 5873.1 5890.8 5458.3 5462.1 5482.2 5501.6 5502.4 4668.0 4785.2 4812.7 4858.8 4868.2 6019.6 6042.2 6055.2 6060.8 6079.9 5874.3 5878.6 5880.9 5886.1 5901.2 5927.0 5933.6 6022.8 6077.3 6093.8 5686.9 5705.3 5719.4 5746.5 5757.3 5802.1 5806.2 5854.8 5854.9 5855.0 5507.5 5530.1 5593.4 5657.5 5710.7 5696.2 5737.6 5741.2 5759.7 5809.5 5558.7 5578.0 5599.3 5601.3 5603.9 5510.8 5527.2 5634.0 5671.4 5713.8 5560.7 5580.1 5586.9 5588.7 5590.6 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#1] ext.html Cycles:180 Average:51647.55 Median:38793.31 stddev:101822.56 (262.5%) stddev-sans-first:102036.14 07:56:48 INFO - PROCESS | 1894 | Values: 625.6 653.6 662.9 678.5 690.5 37035.3 38631.4 38650.6 38658.6 38928.0 39340.8 39374.0 39537.4 39745.4 39804.0 8335.0 8547.5 8563.7 8617.5 8634.1 8416.5 8582.0 8593.6 8596.3 8835.3 8738.6 8767.6 8802.2 8813.3 8836.9 8707.0 8770.9 8774.9 8797.0 8799.9 8766.2 8856.5 8869.6 8871.7 8882.3 30859.7 39392.0 39850.0 39959.6 39967.0 3382.2 3489.9 3599.3 3816.9 3992.1 26286.6 26869.5 27110.3 27584.3 28934.9 4051.4 4099.3 4183.8 4185.9 4186.2 237857.0 238093.0 238107.0 238569.0 240170.8 33717.5 34404.1 34431.8 35443.5 36449.5 34058.5 34153.8 34180.5 34257.1 34268.7 14812.3 15064.3 15098.3 15111.8 15130.2 12485.6 12579.1 12589.6 12590.9 12594.8 8450.9 8498.4 8518.9 8566.4 8624.4 3324.6 3329.1 3347.7 3401.2 3408.9 1060.2 1068.8 1083.7 1084.3 1187.7 31144.8 31323.4 31781.5 31976.0 32437.4 1186.9 1193.3 1260.5 1278.3 1309.9 16297.8 16442.4 16510.2 16796.4 16963.3 460277.0 465489.0 468635.0 469421.0 470077.0 54866.5 56019.2 56085.0 56112.4 56114.0 1379.2 1379.9 1398.6 1407.1 1424.1 28961.6 29454.6 29518.3 29584.6 30391.2 49477.0 49788.0 50049.5 50089.5 50093.5 402811.0 408270.0 408475.0 410050.0 410725.0 27204.9 27305.9 27632.7 27690.4 27703.0 45992.5 46248.5 46264.0 46935.0 46984.3 38998.4 39057.8 39748.6 39896.4 40002.2 37684.1 39226.0 39484.6 40399.4 40714.6 35669.6 41228.6 41528.8 42074.4 42869.4 33496.8 33579.0 33856.0 33998.7 34408.8 26436.2 27123.9 27153.0 27167.9 27302.0 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#2] jquery.html Cycles:180 Average:28903.69 Median:2600.68 stddev:74560.53 (2867.0%) stddev-sans-first:74738.93 07:56:48 INFO - PROCESS | 1894 | Values: 382.3 388.4 398.8 400.4 401.5 17939.6 18414.5 18544.1 18554.9 20068.4 18797.9 18888.0 19184.9 19689.8 19702.8 5529.8 5576.4 5751.7 5763.1 5770.5 5609.6 5629.8 5629.9 5632.9 5646.9 5374.1 5608.4 5666.7 5667.9 5710.6 5634.2 5666.2 5674.8 5678.3 5679.7 4787.5 5025.6 5048.7 5053.4 5071.9 21889.1 21931.0 22789.3 22828.1 22963.9 2307.4 2446.2 2476.8 2724.6 2816.4 14672.9 15253.8 15681.1 15742.3 16140.4 2022.8 2068.7 2098.8 2100.9 2271.8 89941.0 91069.0 93909.5 94483.0 94496.5 16853.5 17049.7 17154.5 17617.7 17658.6 31177.8 31359.4 31418.4 31713.0 31768.0 10097.8 10305.7 10366.1 10423.4 10577.9 8725.9 8736.3 8816.6 8834.6 8897.0 8797.3 8857.3 8931.6 8981.0 8995.0 3390.2 3511.2 3535.2 3561.4 3563.3 939.3 1022.1 1038.0 1064.3 1076.1 17808.6 18708.6 18898.8 18944.5 18997.6 1005.6 1008.6 1031.1 1052.5 1074.8 8383.8 10600.0 10658.6 10706.8 10934.7 445998.0 449425.0 450140.0 451417.0 454462.0 89793.1 91338.0 92280.5 93291.0 93782.0 1048.9 1060.6 1072.0 1072.0 1077.1 16290.8 16564.8 16663.3 16803.4 16936.3 36884.8 37935.8 37959.6 38060.4 38781.4 52082.0 55443.4 55488.2 55682.4 56989.4 7183.1 7427.6 8173.6 8344.0 8641.5 12106.6 12383.2 12530.8 12579.3 12835.2 11270.5 11554.9 11580.5 11612.4 11628.5 11246.8 11483.4 11498.8 11528.8 11598.6 11743.5 11769.0 11775.3 11835.2 11924.5 7623.5 7696.6 7703.4 7757.0 7902.8 11441.7 11657.3 11745.9 11800.1 11855.9 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#3] mootools.html Cycles:180 Average:5510.97 Median:5095.09 stddev:2995.80 (58.8%) stddev-sans-first:2989.09 07:56:48 INFO - PROCESS | 1894 | Values: 1507.2 1558.5 1713.9 1797.4 1842.8 7134.9 8062.8 8096.9 8354.3 8361.4 8097.2 8148.9 8214.5 8231.7 8247.0 2313.1 2337.2 2340.4 2343.2 2350.2 2223.2 2275.1 2325.5 2336.2 2337.3 2274.7 2316.9 2319.1 2337.6 2359.9 2188.0 2190.5 2198.1 2199.8 2227.1 2282.8 2285.9 2298.4 2299.2 2300.8 8292.0 8412.4 8418.5 8427.9 8429.9 5025.9 5225.9 5238.9 5240.1 5274.1 3279.0 3291.3 3372.0 3390.9 3403.9 1143.3 1148.2 1149.8 1165.6 1175.8 11204.4 11211.9 11220.6 11331.9 11332.9 4410.3 4556.5 4745.1 4751.9 4777.7 8918.2 8998.8 9047.9 9072.7 9081.3 5089.8 5105.7 5110.9 5142.1 5198.3 4161.3 4675.0 4777.6 4793.7 4845.4 3645.9 3649.9 3726.4 3736.4 3777.4 1119.1 1136.9 1142.8 1146.3 1147.3 984.7 1030.4 1038.9 1043.2 1043.9 5707.6 5811.0 5853.2 5859.6 6004.8 878.2 919.6 974.9 993.2 1006.8 4119.3 4232.7 4258.9 4279.6 4303.5 9819.8 10050.5 10154.3 10158.8 10161.6 9682.4 9975.4 10100.0 10122.6 10319.4 7777.4 7870.4 7891.3 7931.3 8011.0 5537.9 5607.4 5674.7 5702.5 5745.5 9359.2 9437.3 9444.0 9565.6 9594.8 9324.6 9462.3 9717.7 9730.5 9877.3 6541.4 7102.0 7209.9 7386.9 7422.2 7952.3 7960.0 7976.4 7986.1 8012.0 6996.1 7343.9 7359.7 7387.6 7443.9 7082.1 7112.1 7124.1 7140.8 7195.6 6852.7 6961.8 6973.1 6974.9 7001.1 4845.5 4961.5 4967.9 4970.8 5030.3 5065.3 5065.8 5100.4 5190.7 5201.6 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#4] prototype.html Cycles:180 Average:5241.84 Median:5985.02 stddev:1598.03 (26.7%) stddev-sans-first:1559.39 07:56:48 INFO - PROCESS | 1894 | Values: 329.1 333.6 338.0 339.3 342.2 5903.7 6000.7 6019.9 6023.8 6035.4 5966.2 5974.8 5981.3 5988.7 5989.1 4307.9 4409.5 4530.5 4540.8 4550.2 4503.4 4537.6 4546.6 4549.7 4555.7 4515.5 4524.4 4553.3 4554.5 4561.5 4270.6 4479.2 4483.6 4487.8 4506.1 3845.5 3861.5 3885.8 3890.5 3890.7 5711.1 5747.3 5768.3 5779.2 5793.4 5083.4 5203.1 5207.6 5226.5 5255.6 6224.4 6294.7 6295.4 6297.3 6310.1 4203.5 4335.8 4340.4 4342.2 4354.1 6564.3 6626.5 6635.2 6638.9 6643.5 4363.3 4365.0 4373.1 4378.5 4384.7 4341.6 4447.6 4457.9 4464.6 4482.9 5166.4 5167.9 5181.7 5184.4 5202.4 6275.4 6293.8 6301.6 6329.2 6329.3 1503.5 1531.8 1557.2 1558.5 1565.3 961.1 1012.1 1022.0 1025.2 1025.6 5881.2 5958.8 5970.6 6052.8 6056.9 6296.8 6410.8 6453.7 6470.2 6500.7 5791.2 5967.9 5975.8 5976.1 5998.1 3434.1 3444.2 3492.4 3498.2 3506.2 6562.3 6694.6 6764.4 6771.4 6804.5 6496.3 6528.7 6548.8 6550.0 6577.3 6479.2 6683.5 6688.4 6704.8 6722.1 6397.1 6400.2 6403.6 6438.6 6448.3 6259.7 6301.3 6376.0 6391.2 6418.8 6667.3 6670.2 6742.4 6747.2 6752.6 4409.7 4418.5 4421.5 4422.8 4427.3 6290.2 6449.3 6466.8 6470.6 6478.0 6253.7 6279.5 6289.1 6326.4 6334.8 6224.8 6275.6 6278.3 6293.7 6321.6 5925.2 6058.3 6066.2 6226.8 6252.7 6443.8 6446.6 6477.6 6480.6 6495.5 6138.6 6158.4 6316.9 6364.6 6376.4 07:56:48 INFO - PROCESS | 1894 | 07:56:48 INFO - PROCESS | 1894 | [#5] yui.html Cycles:180 Average:14659.41 Median:4520.21 stddev:16664.07 (368.7%) stddev-sans-first:16678.01 07:56:48 INFO - PROCESS | 1894 | Values: 734.6 741.3 798.7 856.9 857.0 13965.2 14827.9 15170.5 15190.8 15260.8 14073.6 14079.4 14178.5 14228.3 14240.5 823.8 860.9 867.4 867.7 867.9 835.3 838.4 838.7 839.4 842.3 884.9 886.2 887.1 887.5 889.2 866.4 877.0 881.0 881.6 888.4 643.4 648.7 649.1 649.2 653.7 13225.5 13376.3 13453.0 13500.4 13513.8 13905.5 13929.7 14022.6 14051.6 14052.4 11636.1 11654.8 11729.9 11751.2 12029.5 3732.9 3737.8 3822.9 3835.9 3896.4 57103.0 57112.0 57227.1 57372.1 57773.7 10662.4 10681.6 10687.3 10694.2 10790.1 19151.2 19161.4 19168.1 19170.7 19186.0 8365.0 8432.5 8488.2 8498.4 8548.7 4953.0 5015.6 5048.6 5085.3 5110.9 3411.9 3484.9 3509.1 3509.6 3511.8 624.4 639.0 639.5 640.0 641.5 741.4 761.5 768.6 775.5 781.6 9175.9 9394.2 9400.8 9562.2 9617.0 734.6 736.4 743.0 749.2 766.3 4515.2 4525.2 4540.4 4573.2 4665.7 61085.4 62312.0 62595.4 62992.4 63089.0 53107.7 53644.0 54487.0 54549.0 54999.0 46343.0 46801.0 46898.5 47261.3 47738.3 9009.9 9073.4 9299.3 9380.3 9432.2 28841.6 29256.4 29487.7 31224.8 32284.2 34327.3 34606.3 42393.8 42489.4 44038.0 12467.1 12595.7 12660.6 12715.9 12904.6 13142.7 13377.4 13549.7 13603.6 13961.4 13019.9 13020.5 13058.3 13224.3 13727.5 12793.6 13136.6 13193.3 13830.0 13833.7 12808.4 13231.8 13351.3 13354.5 13354.8 10624.5 10857.2 10910.9 11056.7 11470.2 10534.5 10888.8 10950.7 11035.2 11155.9 07:56:48 INFO - PROCESS | 1894 | -------- Summary: end -------- 07:56:48 INFO - PROCESS | 1894 | 07:56:49 INFO - TEST-INFO | 1894: exit 0 07:56:49 INFO - TEST-OK | dromaeo_css | took 1110127ms 07:56:49 INFO - TEST-START | kraken 07:56:49 INFO - operating with platform_type : linux_ 07:56:49 INFO - Initialising browser for kraken test... 07:56:49 INFO - TEST-INFO | started process 2122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5w_SH/profile http://localhost:59886/getInfo.html) 07:56:53 INFO - PROCESS | 2122 | 07:56:53 INFO - PROCESS | 2122 | (process:2190): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:56:53 INFO - PROCESS | 2122 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:56:54 INFO - PROCESS | 2122 | __metrics Screen width/height:1600/1200 07:56:54 INFO - PROCESS | 2122 | colorDepth:24 07:56:54 INFO - PROCESS | 2122 | Browser inner width/height: 1024/697 07:56:54 INFO - PROCESS | 2122 | __metrics 07:56:55 ERROR - PROCESS | 2122 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:56:55 INFO - TEST-INFO | 2122: exit 0 07:56:55 INFO - Browser initialized. 07:56:55 INFO - Running cycle 1/1 for kraken test... 07:56:55 INFO - TEST-INFO | started process 2241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5w_SH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:57 INFO - PROCESS | 2241 | 07:56:57 INFO - PROCESS | 2241 | (process:2302): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:57:07 INFO - PROCESS | 2241 | RSS: Main: 163086336 07:57:07 INFO - PROCESS | 2241 | 07:57:10 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:11 INFO - PROCESS | 2241 | RSS: Main: 167161856 07:57:11 INFO - PROCESS | 2241 | 07:57:13 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-dft) 07:57:14 INFO - PROCESS | 2241 | RSS: Main: 171507712 07:57:14 INFO - PROCESS | 2241 | 07:57:17 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-fft) 07:57:18 INFO - PROCESS | 2241 | RSS: Main: 161980416 07:57:18 INFO - PROCESS | 2241 | 07:57:20 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59886/tests/kraken/driver.html?testName=audio-oscillator) 07:57:20 INFO - PROCESS | 2241 | RSS: Main: 163258368 07:57:20 INFO - PROCESS | 2241 | 07:57:23 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:23 INFO - PROCESS | 2241 | RSS: Main: 163278848 07:57:23 INFO - PROCESS | 2241 | 07:57:26 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:27 INFO - PROCESS | 2241 | RSS: Main: 163450880 07:57:27 INFO - PROCESS | 2241 | 07:57:30 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59886/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:31 INFO - PROCESS | 2241 | RSS: Main: 166113280 07:57:31 INFO - PROCESS | 2241 | 07:57:34 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59886/tests/kraken/driver.html?testName=json-parse-financial) 07:57:34 INFO - PROCESS | 2241 | RSS: Main: 166379520 07:57:34 INFO - PROCESS | 2241 | 07:57:36 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59886/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:37 INFO - PROCESS | 2241 | RSS: Main: 166367232 07:57:37 INFO - PROCESS | 2241 | 07:57:38 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:39 INFO - PROCESS | 2241 | RSS: Main: 165781504 07:57:39 INFO - PROCESS | 2241 | 07:57:41 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:42 INFO - PROCESS | 2241 | RSS: Main: 166060032 07:57:42 INFO - PROCESS | 2241 | 07:57:44 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:45 INFO - PROCESS | 2241 | RSS: Main: 166793216 07:57:45 INFO - PROCESS | 2241 | 07:57:48 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:48 INFO - PROCESS | 2241 | RSS: Main: 167067648 07:57:48 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | Cycle 1(1): loaded http://localhost:59886/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59886/tests/kraken/driver.html?testName=ai-astar) 07:57:50 INFO - PROCESS | 2241 | RSS: Main: 168206336 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | __start_tp_report 07:57:50 INFO - PROCESS | 2241 | _x_x_mozilla_page_load 07:57:50 INFO - PROCESS | 2241 | _x_x_mozilla_page_load_details 07:57:50 INFO - PROCESS | 2241 | |i|pagename|runs| 07:57:50 INFO - PROCESS | 2241 | |0;ai-astar;112;105;112;117;114;124;113;111;112;114 07:57:50 INFO - PROCESS | 2241 | |1;audio-beat-detection;162;129;153;195;132;153;154;132;193;133 07:57:50 INFO - PROCESS | 2241 | |2;audio-dft;162;162;162;163;164;169;167;172;165;161 07:57:50 INFO - PROCESS | 2241 | |3;audio-fft;73;74;77;160;74;74;77;75;160;77 07:57:50 INFO - PROCESS | 2241 | |4;audio-oscillator;95;92;141;92;93;92;143;92;93;150 07:57:50 INFO - PROCESS | 2241 | |5;imaging-gaussian-blur;117;119;117;118;118;117;117;117;117;117 07:57:50 INFO - PROCESS | 2241 | |6;imaging-darkroom;146;147;147;147;147;147;147;146;146;148 07:57:50 INFO - PROCESS | 2241 | |7;imaging-desaturate;96;96;96;96;95;96;95;96;96;96 07:57:50 INFO - PROCESS | 2241 | |8;json-parse-financial;59;58;59;58;57;62;57;79;57;65 07:57:50 INFO - PROCESS | 2241 | |9;json-stringify-tinderbox;61;62;61;61;62;61;61;62;61;62 07:57:50 INFO - PROCESS | 2241 | |10;stanford-crypto-aes;86;77;79;79;81;78;77;86;79;79 07:57:50 INFO - PROCESS | 2241 | |11;stanford-crypto-ccm;135;132;128;128;125;125;126;128;159;126 07:57:50 INFO - PROCESS | 2241 | |12;stanford-crypto-pbkdf2;171;167;169;164;175;162;165;167;166;166 07:57:50 INFO - PROCESS | 2241 | |13;stanford-crypto-sha256-iterative;70;69;72;70;67;69;68;66;66;68 07:57:50 INFO - PROCESS | 2241 | __end_tp_report 07:57:50 INFO - PROCESS | 2241 | __start_cc_report 07:57:50 INFO - PROCESS | 2241 | _x_x_mozilla_cycle_collect,828 07:57:50 INFO - PROCESS | 2241 | __end_cc_report 07:57:50 INFO - PROCESS | 2241 | __startTimestamp1460645870717__endTimestamp 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | ------- Summary: start ------- 07:57:50 INFO - PROCESS | 2241 | Number of tests: 14 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:4.81 (4.2%) stddev-sans-first:5.08 07:57:50 INFO - PROCESS | 2241 | Values: 112.0 105.0 112.0 117.0 114.0 124.0 113.0 111.0 112.0 114.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:153.50 stddev:24.27 (15.8%) stddev-sans-first:25.55 07:57:50 INFO - PROCESS | 2241 | Values: 162.0 129.0 153.0 195.0 132.0 153.0 154.0 132.0 193.0 133.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:3.59 (2.2%) stddev-sans-first:3.67 07:57:50 INFO - PROCESS | 2241 | Values: 162.0 162.0 162.0 163.0 164.0 169.0 167.0 172.0 165.0 161.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#3] audio-fft Cycles:10 Average:92.10 Median:74.50 stddev:35.82 (48.1%) stddev-sans-first:37.32 07:57:50 INFO - PROCESS | 2241 | Values: 73.0 74.0 77.0 160.0 74.0 74.0 77.0 75.0 160.0 77.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:92.00 stddev:25.21 (27.4%) stddev-sans-first:26.28 07:57:50 INFO - PROCESS | 2241 | Values: 95.0 92.0 141.0 92.0 93.0 92.0 143.0 92.0 93.0 150.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:57:50 INFO - PROCESS | 2241 | Values: 117.0 119.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 07:57:50 INFO - PROCESS | 2241 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 148.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:50 INFO - PROCESS | 2241 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:59.00 stddev:6.79 (11.5%) stddev-sans-first:7.16 07:57:50 INFO - PROCESS | 2241 | Values: 59.0 58.0 59.0 58.0 57.0 62.0 57.0 79.0 57.0 65.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:57:50 INFO - PROCESS | 2241 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:3.31 (4.2%) stddev-sans-first:2.74 07:57:50 INFO - PROCESS | 2241 | Values: 86.0 77.0 79.0 79.0 81.0 78.0 77.0 86.0 79.0 79.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:128.00 stddev:10.27 (8.0%) stddev-sans-first:10.80 07:57:50 INFO - PROCESS | 2241 | Values: 135.0 132.0 128.0 128.0 125.0 125.0 126.0 128.0 159.0 126.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:3.71 (2.2%) stddev-sans-first:3.67 07:57:50 INFO - PROCESS | 2241 | Values: 171.0 167.0 169.0 164.0 175.0 162.0 165.0 167.0 166.0 166.0 07:57:50 INFO - PROCESS | 2241 | 07:57:50 INFO - PROCESS | 2241 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.90 (2.8%) stddev-sans-first:1.94 07:57:50 INFO - PROCESS | 2241 | Values: 70.0 69.0 72.0 70.0 67.0 69.0 68.0 66.0 66.0 68.0 07:57:50 INFO - PROCESS | 2241 | -------- Summary: end -------- 07:57:50 INFO - PROCESS | 2241 | 07:57:51 INFO - TEST-INFO | 2241: exit 0 07:57:51 INFO - TEST-OK | kraken | took 62132ms 07:57:51 INFO - SUITE-END | took 1172s 07:57:51 INFO - Completed test suite (00:19:32) 07:57:51 INFO - javascript benchmark 07:57:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.5114381698927, 3145.4809956357203, 3154.2587491939385, 3167.5723777290086, 3192.3455691583226, 5381.677099374036, 5382.838514844556, 5387.595930305228, 5450.890982180354, 5497.47773961474, 5298.36419629644, 5376.193570964358, 5453.836384908459, 5467.152591348347, 5469.398366179727, 4859.076775412669, 4876.195427754416, 4930.161872481669, 4947.109520286347, 4995.550400463958, 4927.704337739729, 4945.579625731817, 4991.500849914997, 5008.474110218429, 5059.924101138467, 4807.78364973577, 4836.54052864979, 4871.171900776876, 4875.195592727196, 4889.0, 4876.439209490918, 4888.095702295087, 4892.8532144035735, 4916.508349165055, 4950.232713929347, 4842.830500932486, 4865.805367785284, 4877.317175595419, 4884.438289596706, 4899.975500122512, 5237.79048838046, 5291.259223708646, 5307.416184219733, 5307.787688492455, 5320.733963301858, 5720.799772008001, 5726.026575482178, 5736.426357364272, 5754.539636829044, 5756.079027355603, 5632.633878797906, 5784.710764461802, 5798.42015798421, 5799.420057994209, 5883.441073098049, 5410.404855465896, 5414.160805075219, 5415.296011518517, 5423.2407462954825, 5473.452654734535, 5861.296644402699, 5886.0, 5925.259342582177, 5942.316633587193, 5948.226730525091, 5501.669899806025, 5616.494515493625, 5675.120356344773, 5693.516051135617, 5703.429657034263, 5781.653100813965, 5799.623024503394, 5800.796972105956, 5802.796902108406, 5857.47282744555, 5668.461496157858, 5745.0, 5774.220480235199, 5783.971080144573, 5802.042662960649, 5597.74810133545, 5683.175939488834, 5738.368779434259, 5743.425657434307, 5757.424257574209, 4256.787160642018, 4271.209826182104, 4277.123189746095, 4316.330968699856, 4333.0, 3877.0307423144213, 3887.611238876146, 3892.3188442023097, 3912.68698504119, 3918.040080180374, 5231.24146998683, 5456.372517160577, 5462.426445223195, 5506.256655351556, 5517.5585953123655, 5851.239338885917, 5855.297364316224, 5863.501602363762, 5873.060310350324, 5890.7938222162875, 5458.263134476874, 5462.126059830408, 5482.23248745176, 5501.614886957955, 5502.449755024466, 4668.043051174501, 4785.186518291829, 4812.687175333662, 4858.7570621469495, 4868.172410690191, 6019.578629495893, 6042.154098426224, 6055.2128223331565, 6060.757569697251, 6079.939200608026, 5874.324452687995, 5878.588498805128, 5880.941190588211, 5886.05823068307, 5901.173835662925, 5926.970365148319, 5933.614315069507, 6022.759089636365, 6077.301110372364, 6093.75624974996, 5686.886262274814, 5705.286839145107, 5719.399463056319, 5746.482816546531, 5757.3379061406795, 5802.1296805479515, 5806.187133801355, 5854.765809367577, 5854.853628659318, 5855.00464920956, 5507.504324610804, 5530.142827861688, 5593.384727679871, 5657.547396208376, 5710.65736055838, 5696.231008813757, 5737.56968227393, 5741.224934633938, 5759.65442073477, 5809.477147056785, 5558.694271815089, 5577.972110139423, 5599.32808063035, 5601.271834661468, 5603.887922241451, 5510.752016159202, 5527.198556209408, 5633.971830140823, 5671.404502527175, 5713.771449141987, 5560.666360018412, 5580.107182850725, 5586.916196256978, 5588.692621905834, 5590.636608620427], "value": 5319.432395702314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.5777350288557, 653.5719103986888, 662.8541720821421, 678.4979115454563, 690.4752388184984, 37035.25929481409, 38631.420528692055, 38650.61349386505, 38658.61341386585, 38928.0, 39340.80329598348, 39374.0, 39537.40693889594, 39745.403818942665, 39804.0, 8335.041470230924, 8547.529885856307, 8563.700270490534, 8617.526036068013, 8634.093420190884, 8416.537090460022, 8581.957090214572, 8593.613287402051, 8596.312295016414, 8835.293176545892, 8738.606762695694, 8767.56162191891, 8802.207801297882, 8813.338999575057, 8836.911630883706, 8706.956465217696, 8770.912290877106, 8774.868376974351, 8796.956015219883, 8799.868001979976, 8766.21104100634, 8856.468611883243, 8869.55652217393, 8871.733847984571, 8882.333824963154, 30859.691403085908, 39392.0, 39850.0, 39959.60040399588, 39967.0, 3382.2072518327673, 3489.8778542750883, 3599.262151258986, 3816.9045773855596, 3992.0818211811156, 26286.6057009145, 26869.462610747676, 27110.32224194391, 27584.310392240153, 28934.85532572345, 4051.3517837145914, 4099.3031184698375, 4183.769892655902, 4185.895352616209, 4186.204621121977, 237857.0, 238093.0, 238107.0, 238569.0, 240170.7991460049, 33717.494237586456, 34404.13989650229, 34431.827840860635, 35443.4683479748, 36449.453258201145, 34058.48912266318, 34153.829230854186, 34180.48729269063, 34257.143571410415, 34268.65731342655, 14812.333444995002, 15064.32210550506, 15098.320575574126, 15111.773323400157, 15130.167840768643, 12485.56300529477, 12579.119461637598, 12589.622311330675, 12590.874091259153, 12594.81107783384, 8450.901382820193, 8498.405111642125, 8518.914810851937, 8566.400351975302, 8624.396292259482, 3324.5511855899626, 3329.1011426914597, 3347.7489188310974, 3401.200717831308, 3408.9488657670154, 1060.226034994443, 1068.8289873620338, 1083.669480808361, 1084.3331351219101, 1187.6615164678026, 31144.844275778476, 31323.373532529222, 31781.52327715086, 31976.0, 32437.35125297528, 1186.887245711656, 1193.349624454657, 1260.521002019227, 1278.341654048166, 1309.9148555343872, 16297.755533667005, 16442.40810228786, 16510.17449127539, 16796.412125575545, 16963.321467141177, 460277.0, 465489.0, 468635.0, 469421.0, 470077.0, 54866.451335486134, 56019.15971260434, 56085.0, 56112.43887561072, 56114.0, 1379.2483096712315, 1379.8551152129082, 1398.6013986013936, 1407.1486750515994, 1424.0956992309957, 28961.56557651679, 29454.558181626864, 29518.262043448227, 29584.556231656974, 30391.240218994702, 49477.0, 49788.02119787992, 50049.49950500448, 50089.49910500849, 50093.49906500888, 402811.0, 408270.0, 408475.0, 410050.0, 410725.0, 27204.863975679997, 27305.85982612025, 27632.723672763015, 27690.44619107647, 27703.0, 45992.54007459882, 46248.537514624426, 46264.0, 46935.0, 46984.29523557081, 38998.41502377523, 39057.80471097626, 39748.60251397449, 39896.401553977295, 40002.1999560013, 37684.05789855166, 39226.0, 39484.60515394809, 40399.39400909047, 40714.59285407227, 35669.643303566634, 41228.58771412368, 41528.79235603803, 42074.36888446737, 42869.356959645, 33496.83251583727, 33579.0, 33856.0, 33998.66001339955, 34408.82795586006, 26436.206913792616, 27123.86438067876, 27153.0, 27167.86416067986, 27302.0], "value": 17965.59784738862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.29275839696567, 388.3669618521809, 398.7627361719777, 400.35742633073914, 401.5081525131714, 17939.55151121221, 18414.539636509093, 18544.07279636018, 18554.90722546389, 20068.39794806158, 18797.906010469927, 18888.0, 19184.904075479604, 19689.803101968977, 19702.802971970275, 5529.806456774014, 5576.442355764431, 5751.683657398841, 5763.106718458645, 5770.480656740892, 5609.607327487057, 5629.831105066834, 5629.943700563003, 5632.859178520529, 5646.915296270559, 5374.140137577989, 5608.43915608438, 5666.716664166795, 5667.914981275284, 5710.628809127415, 5634.154876768476, 5666.235058267122, 5674.779922316701, 5678.318601767773, 5679.744411501492, 4787.521247875219, 5025.623078269145, 5048.671836330626, 5053.444121146671, 5071.949280507185, 21889.12443502258, 21931.0, 22789.31632051041, 22828.086876524918, 22963.88518057399, 2307.3654744945106, 2446.204983380391, 2476.777090061903, 2724.577690457982, 2816.436712657456, 14672.853271467255, 15253.771193432107, 15681.137537435436, 15742.291596878167, 16140.35438582467, 2022.8280596149345, 2068.7103805467245, 2098.790120987904, 2100.926467573643, 2271.8409711320214, 89941.0, 91068.99999999933, 93909.53045234799, 94483.0, 94496.52751736266, 16853.494395168163, 17049.7442538362, 17154.485365438806, 17617.735733964, 17658.646827063385, 31177.8441107793, 31359.37281254362, 31418.37163256722, 31713.04860854178, 31768.0, 10097.848532272023, 10305.74235644115, 10366.118879895294, 10423.426711530787, 10577.894221057844, 8725.869111963326, 8736.301095912311, 8816.647334106692, 8834.64661413549, 8896.955515222511, 8797.252233560092, 8857.29141668665, 8931.553422328858, 8980.955095224483, 8995.0, 3390.1524618845287, 3511.17487390463, 3535.1869070114017, 3561.4479755637917, 3563.2813667380897, 939.33307351781, 1022.1465076660922, 1037.984430233547, 1064.2762921213493, 1076.1283360478037, 17808.55478613045, 18708.625827483374, 18898.81101188998, 18944.52638684044, 18997.62004759897, 1005.5776573838859, 1008.6419321141036, 1031.138998935882, 1052.4632437456798, 1074.8387741838787, 8383.832323353621, 10600.0, 10658.626948056935, 10706.785864282827, 10934.671959841218, 445998.0, 449425.0, 450140.0, 451417.0, 454462.0, 89793.10206897979, 91338.0, 92280.53859730659, 93291.0, 93782.0, 1048.8584041154347, 1060.5545670818274, 1071.9839202411813, 1072.0, 1077.06833588945, 16290.755638665667, 16564.83435165633, 16663.250153743353, 16803.41188058412, 16936.322547097978, 36884.81557592195, 37935.81032094822, 37959.620403795605, 38060.42909356306, 38781.41827872528, 52082.0, 55443.445565545444, 55488.167677485675, 55682.44317556773, 56989.43010570007, 7183.102112235971, 7427.5914824683, 8173.632186551738, 8343.95828020856, 8641.524716140673, 12106.636800895987, 12383.19509231897, 12530.812037819622, 12579.308138052129, 12835.165714228919, 11270.492827822603, 11554.884451155716, 11580.478878450322, 11612.361320127475, 11628.476718547854, 11246.775064498828, 11483.36841473727, 11498.770024599295, 11528.82706759416, 11598.594049208237, 11743.530258789553, 11769.0, 11775.293482391084, 11835.171537992257, 11924.463399146885, 7623.542587444771, 7696.560655492651, 7703.383729301754, 7757.0, 7902.762917112495, 11441.656750297505, 11657.300561966309, 11745.882541174478, 11800.055995520166, 11855.940720296343], "value": 9959.111170975722, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1507.17858766972, 1558.51685977347, 1713.8885972411792, 1797.4338083503687, 1842.797292297847, 7134.8573028539395, 8062.798430039252, 8096.91903080969, 8354.289885359753, 8361.414700970927, 8097.1902809718995, 8148.877766833488, 8214.548199849007, 8231.711890083849, 8246.95876520618, 2313.144136669435, 2337.2053501809382, 2340.4499942513494, 2343.16817529777, 2350.236173243694, 2223.2440970070174, 2275.1468199425217, 2325.4883925536355, 2336.19401306549, 2337.333859849943, 2274.6815445837597, 2316.8957396917094, 2319.072371051576, 2337.637666161748, 2359.8938047787806, 2187.9562408751817, 2190.485235969546, 2198.0548364203387, 2199.7800219978035, 2227.098025299756, 2282.7717228277206, 2285.908563657452, 2298.425393651587, 2299.1722979727283, 2300.815934725218, 8292.0, 8412.411131220817, 8418.536980466071, 8427.873581896276, 8429.915700843036, 5025.874353141201, 5225.895482090337, 5238.895222095575, 5240.056789777838, 5274.077036518594, 3279.0, 3291.325278317939, 3371.9662803372144, 3390.9152271193416, 3403.897883063512, 1143.2511704833348, 1148.1561052626314, 1149.7987852125846, 1165.626999360205, 1175.7883580955424, 11204.383758893258, 11211.943940280247, 11220.551177952872, 11331.943340283246, 11332.886671133183, 4410.29435290352, 4556.498785133699, 4745.1221524018165, 4751.881202969884, 4777.689450185727, 8918.24194943437, 8998.775030624287, 9047.864282035775, 9072.682456114137, 9081.273498120134, 5089.770960306795, 5105.744712764421, 5110.923336149961, 5142.074426603247, 5198.32421785173, 4161.292580261363, 4674.976625116853, 4777.617790576745, 4793.664443488922, 4845.394325709286, 3645.908852278661, 3649.872254471134, 3726.3851464508593, 3736.3834967230646, 3777.395616701315, 1119.1494464207099, 1136.9488373023235, 1142.845715828369, 1146.2606618730872, 1147.2886810177577, 984.6799790068256, 1030.4229631406436, 1038.85456036155, 1043.186314674555, 1043.9373637581768, 5707.6290041147195, 5811.0, 5853.239078919798, 5859.589828712034, 6004.789832355847, 878.2315473960285, 919.5540163020929, 974.9220062394992, 993.1607791416242, 1006.8238058339762, 4119.299719047769, 4232.746035237896, 4258.936115958263, 4279.614834664895, 4303.462067241595, 9819.754506137404, 10050.497475126214, 10154.339967902211, 10158.847617285746, 10161.593536258615, 9682.370645907993, 9975.401475911469, 10100.0, 10122.645707400206, 10319.380837149794, 7777.416693747991, 7870.409719270963, 7891.28978391936, 7931.286184243446, 8011.038675358877, 5537.861553461034, 5607.355154157324, 5674.687892165971, 5702.5437964961875, 5745.511631511368, 9359.15767580921, 9437.339386242897, 9443.95278023633, 9565.617375305188, 9594.808103838024, 9324.627014919328, 9462.337636365664, 9717.708468745948, 9730.464824434725, 9877.259205559756, 6541.443977261986, 7102.0, 7209.855802883808, 7386.889196661947, 7422.183559808309, 7952.284294413531, 7960.044794624682, 7976.401769867167, 7986.081600616004, 8012.0, 6996.090508233897, 7343.889841652486, 7359.668814903235, 7387.630618469163, 7443.888341674988, 7082.079329687108, 7112.146542414736, 7124.109486314211, 7140.7857764267155, 7195.568265904062, 6852.657367131723, 6961.756338528127, 6973.12835895513, 6974.930250697428, 7001.054857594363, 4845.491223421631, 4961.454240033521, 4967.850964471072, 4970.801167953241, 5030.270610761492, 5065.341505604248, 5065.772040258271, 5100.413452452867, 5190.740462976761, 5201.6098792591465], "value": 4486.201837050408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.0917068889865, 333.57302652604665, 337.9932401351975, 339.3078120633907, 342.1736506337196, 5903.734331955062, 6000.7299671514775, 6019.939800601993, 6023.759049638009, 6035.426634469729, 5966.164736936832, 5974.817627660644, 5981.342052374235, 5988.700564971756, 5989.071693887455, 4307.892302692434, 4409.536998615147, 4530.482288433363, 4540.772961351936, 4550.180967425862, 4503.414556107701, 4537.636989040885, 4546.568076032771, 4549.727016379028, 4555.703879247838, 4515.480719717241, 4524.389207456984, 4553.317002449642, 4554.4990051094355, 4561.498235194143, 4270.615644591986, 4479.193745125876, 4483.574060464251, 4487.820487180509, 4506.053728716974, 3845.5193100862393, 3861.498005259298, 3885.805709714503, 3890.513685789276, 3890.657723085531, 5711.143328500717, 5747.281589801275, 5768.3366412862215, 5779.1620215069, 5793.362730099686, 5083.415407228179, 5203.126874325239, 5207.583393328525, 5226.451222621608, 5255.610131465183, 6224.377562243784, 6294.7482100715915, 6295.433410992987, 6297.275813281485, 6310.0850376695125, 4203.516595591515, 4335.826566937319, 4340.350666746616, 4342.2401079811225, 4354.129174165179, 6564.277929427759, 6626.469882409396, 6635.170603674541, 6638.900416493708, 6643.468522518236, 4363.3018717005125, 4365.0, 4373.081652852937, 4378.5183629800695, 4384.693071484965, 4341.565843415633, 4447.555244475527, 4457.910841783146, 4464.575865292857, 4482.910341793146, 5166.354205724285, 5167.896642067213, 5181.740912954338, 5184.429712731597, 5202.4277329493725, 6275.3724627537795, 6293.811185664437, 6301.590396624205, 6329.177206963065, 6329.3354197809485, 1503.4963287298876, 1531.8008658874276, 1557.1980430078518, 1558.534977121525, 1565.2877940537028, 961.1397798969883, 1012.094175712733, 1021.9795604087876, 1025.2157099818644, 1025.5743866295404, 5881.235439392937, 5958.821235362946, 5970.552208584373, 6052.757889684452, 6056.939430605726, 6296.842578935563, 6410.781951429213, 6453.741850325934, 6470.191226096738, 6500.739970401226, 5791.247137872134, 5967.940320596826, 5975.7609695612555, 5976.103584462366, 5998.070299103646, 3434.059756237718, 3444.225049363873, 3492.4237500812587, 3498.2478767065204, 3506.193575477603, 6562.278149403657, 6694.552305562639, 6764.425023872927, 6771.3905748482875, 6804.455643548505, 6496.317886621931, 6528.706208220547, 6548.8035358939305, 6550.0, 6577.309382514863, 6479.222493300834, 6683.4987375947, 6688.39804417595, 6704.765333213314, 6722.092517510171, 6397.1363865879375, 6400.199975003125, 6403.64779937108, 6438.6136831790245, 6448.29068802422, 6259.6870156492905, 6301.275353334425, 6376.0, 6391.169148010729, 6418.807435776934, 6667.333266673294, 6670.166229221348, 6742.393184613408, 6747.224069232101, 6752.628605426552, 4409.713368631029, 4418.513963463952, 4421.513633500248, 4422.778861056999, 4427.291633338779, 6290.150829637941, 6449.322821103717, 6466.773662921775, 6470.611763294218, 6477.967610161919, 6253.7185826637, 6279.466245369012, 6289.119523266655, 6326.43062124411, 6334.778282760081, 6224.751009959551, 6275.592086514362, 6278.309385967631, 6293.727261823735, 6321.557490975588, 5925.1704761332585, 6058.333583305921, 6066.211392518944, 6226.813195604139, 6252.687365631791, 6443.807895539153, 6446.580972236789, 6477.643729594917, 6480.643564603992, 6495.512836537184, 6138.631682099089, 6158.353372895961, 6316.936830631818, 6364.554481186457, 6376.362363763772], "value": 4718.165260810736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.5555938657111, 741.329097167064, 798.720447843255, 856.8971723393191, 857.018713572959, 13965.162090274565, 14827.851721482783, 15170.469033583826, 15190.848091519081, 15260.771088433668, 14073.648158796035, 14079.436822527086, 14178.50375236867, 14228.288585570706, 14240.501582444616, 823.8064054947098, 860.8579584368572, 867.4101610904582, 867.6659486097866, 867.8828358171661, 835.2691395029349, 838.3921656798833, 838.6896848166188, 839.353697652807, 842.338764070205, 884.907084756101, 886.1979908183073, 887.1439061305839, 887.5384799904047, 889.2397000564489, 866.4411454611771, 876.9693060742875, 881.0352663833124, 881.6385282034399, 888.3958907942597, 643.3694978920637, 648.7145655911384, 649.0880313160018, 649.1723053107279, 653.7090994507446, 13225.537106201236, 13376.264305463195, 13453.0, 13500.39248233822, 13513.797293040612, 13905.513307034205, 13929.721405571832, 14022.579322620337, 14051.578452646334, 14052.36764345607, 11636.127290453165, 11654.76690466186, 11729.88270117305, 11751.177417580773, 12029.458674359676, 3732.9440058399146, 3737.794421306854, 3822.923541529182, 3835.9041023974346, 3896.4350169225304, 57103.0, 57112.0, 57227.14159287614, 57372.139417908766, 57773.71113144408, 10662.413567253876, 10681.626143084955, 10687.25189236746, 10694.197935154894, 10790.136789057013, 19151.233950642098, 19161.425157245307, 19168.13743381551, 19170.71243931342, 19186.0, 8365.0, 8432.494050356998, 8488.236058754619, 8498.447600905922, 8548.658053677907, 4953.0, 5015.573676237488, 5048.596112311006, 5085.338905942278, 5110.948890511122, 3411.8805841795916, 3484.930301393958, 3509.0700964244497, 3509.578850537952, 3511.754177207622, 624.4255285137684, 639.0318667219167, 639.5395315372924, 639.9520035997319, 641.4579680170249, 741.4179868803071, 761.5050217358761, 768.6080099149474, 775.4726785785607, 781.5818537082633, 9175.862362064574, 9394.248460123174, 9400.764980875396, 9562.235021198287, 9617.0, 734.6216698400328, 736.4292673178222, 742.985140297191, 749.2470067582045, 766.2873132483696, 4515.209838278354, 4525.208088584484, 4540.409746732904, 4573.199690054227, 4665.6967297125575, 61085.38914610797, 62312.0, 62595.374046259865, 62992.370076299565, 63089.0, 53107.73446132745, 53644.0, 54487.0, 54549.0, 54999.0, 46343.0, 46801.0, 46898.531014690096, 47261.29108063382, 47738.28392574114, 9009.909900900908, 9073.410228335137, 9299.256059515088, 9380.343375963617, 9432.151106400457, 28841.567376489787, 29256.41487170202, 29487.705122949355, 31224.843875780476, 32284.19289517781, 34327.31345373028, 34606.30787384188, 42393.788031059645, 42489.36265956075, 44038.0, 12467.127301088836, 12595.74808503843, 12660.556880509139, 12715.872841271468, 12904.612861614167, 13142.671433213864, 13377.398017089448, 13549.661258468617, 13603.591892243248, 13961.4415423386, 13019.869801302244, 13020.47918083266, 13058.34708264564, 13224.338783061, 13727.519536816164, 12793.61619151427, 13136.605901822579, 13193.274369909746, 13830.03189776706, 13833.723325533232, 12808.359582020676, 13231.80152297697, 13351.265680387283, 13354.532591359255, 13354.799678004643, 10624.468776561296, 10857.239993200401, 10910.890891091305, 11056.668299951014, 11470.197086203885, 10534.473276336306, 10888.836667450152, 10950.726231844268, 11035.172362073037, 11155.944220278847], "value": 6846.622047868972, "unit": "score"}], "name": "dromaeo_css", "value": 7188.128655869277, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 112.0, 117.0, 114.0, 124.0, 113.0, 111.0, 112.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 153.0, 195.0, 132.0, 153.0, 154.0, 132.0, 193.0, 133.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 164.0, 169.0, 167.0, 172.0, 165.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 77.0, 160.0, 74.0, 74.0, 77.0, 75.0, 160.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 92.0, 141.0, 92.0, 93.0, 92.0, 143.0, 92.0, 93.0, 150.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 58.0, 57.0, 62.0, 57.0, 79.0, 57.0, 65.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 77.0, 79.0, 79.0, 81.0, 78.0, 77.0, 86.0, 79.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 128.0, 128.0, 125.0, 125.0, 126.0, 128.0, 159.0, 126.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 169.0, 164.0, 175.0, 162.0, 165.0, 167.0, 166.0, 166.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 70.0, 67.0, 69.0, 68.0, 66.0, 66.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1561.6, "alertThreshold": 2.0}]} 07:57:51 INFO - Return code: 0 07:57:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:57:52 ERROR - # TBPL SUCCESS # 07:57:52 INFO - Running post-action listener: _resource_record_post_action 07:57:52 INFO - Running post-run listener: _resource_record_post_run 07:57:53 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535232512; Read time: 16; Write time: 573688 07:57:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244142080; Read time: 0; Write time: 338068 07:57:53 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291090432; Read time: 16; Write time: 235620 07:57:53 INFO - Running post-run listener: _upload_blobber_files 07:57:53 INFO - Blob upload gear active. 07:57:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:57:53 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:57:53 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:57:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:54 INFO - (blobuploader) - INFO - Done attempting. 07:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:57:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:55 INFO - (blobuploader) - INFO - Done attempting. 07:57:55 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:55 INFO - Return code: 0 07:57:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/422e1effb6ea4d966fb54eff435023352d1f2dc397ad64b1e36e47caa74143196a65d07bd3bbea988ba0b182786bf4358a1b4e3d763f657155a0c5feae9388b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e4bf5e670fae4489ee57173e4068c53608ef2f4847cb0758bb553551fc30676f71542472ef80f550ec93cd46b84e07c90dc14ec24bee9f9fe46ddf52a20fef"} 07:57:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:55 INFO - Contents: 07:57:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/422e1effb6ea4d966fb54eff435023352d1f2dc397ad64b1e36e47caa74143196a65d07bd3bbea988ba0b182786bf4358a1b4e3d763f657155a0c5feae9388b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e4bf5e670fae4489ee57173e4068c53608ef2f4847cb0758bb553551fc30676f71542472ef80f550ec93cd46b84e07c90dc14ec24bee9f9fe46ddf52a20fef"} 07:57:55 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:55 INFO - Copying logs to upload dir... 07:57:55 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.192741 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-14 07:57:54.576593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:57:54.580744) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 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-Inbound/sha512/422e1effb6ea4d966fb54eff435023352d1f2dc397ad64b1e36e47caa74143196a65d07bd3bbea988ba0b182786bf4358a1b4e3d763f657155a0c5feae9388b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e4bf5e670fae4489ee57173e4068c53608ef2f4847cb0758bb553551fc30676f71542472ef80f550ec93cd46b84e07c90dc14ec24bee9f9fe46ddf52a20fef"} build_url:https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/BRaddM_WRa-gPAbmvfEekg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/422e1effb6ea4d966fb54eff435023352d1f2dc397ad64b1e36e47caa74143196a65d07bd3bbea988ba0b182786bf4358a1b4e3d763f657155a0c5feae9388b6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6e4bf5e670fae4489ee57173e4068c53608ef2f4847cb0758bb553551fc30676f71542472ef80f550ec93cd46b84e07c90dc14ec24bee9f9fe46ddf52a20fef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 07:57:54.611584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:57:54.612135) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1460644637.231029-936638166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 07:57:54.695205) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:57:54.695539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 07:57:54.695869) ========= ========= Total master_lag: 0.17 =========