builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1461031164.6 results: success (0) buildid: 20160418163008 builduid: af71cc78be7a492ab9ea1f85b2527209 revision: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.604692) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.605173) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.605494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.658920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.659243) ========= 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=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 18:59:24-- 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% 66.8M=0s 2016-04-18 18:59:24 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201988 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.897759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:24.898139) ========= 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=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.210038 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.120856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.121272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 67ac40fb8f680ea5e03805552187ba1b5e8392a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 67ac40fb8f680ea5e03805552187ba1b5e8392a1 --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=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 18:59:25,261 truncating revision to first 12 chars 2016-04-18 18:59:25,261 Setting DEBUG logging. 2016-04-18 18:59:25,261 attempt 1/10 2016-04-18 18:59:25,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/67ac40fb8f68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 18:59:25,516 unpacking tar archive at: mozilla-central-67ac40fb8f68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534064 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.671360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.671973) ========= script_repo_revision: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.672456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.672775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 18:59:25.683894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-18 18:59:25.684339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:26 INFO - MultiFileLogger online at 20160418 18:59:26 in /builds/slave/test 18:59:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:59:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:26 INFO - {'append_to_log': False, 18:59:26 INFO - 'base_work_dir': '/builds/slave/test', 18:59:26 INFO - 'blob_upload_branch': 'Firefox', 18:59:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:26 INFO - 'branch': 'Firefox', 18:59:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:26 INFO - 'config_files': ('talos/linux_config.py',), 18:59:26 INFO - 'default_actions': ('clobber', 18:59:26 INFO - 'read-buildbot-config', 18:59:26 INFO - 'download-and-extract', 18:59:26 INFO - 'populate-webroot', 18:59:26 INFO - 'create-virtualenv', 18:59:26 INFO - 'install', 18:59:26 INFO - 'run-tests'), 18:59:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:26 INFO - 'download_minidump_stackwalk': True, 18:59:26 INFO - 'download_symbols': 'ondemand', 18:59:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:26 INFO - 'installer_path': 'installer.exe', 18:59:26 INFO - 'log_level': 'info', 18:59:26 INFO - 'log_name': 'talos', 18:59:26 INFO - 'log_to_console': True, 18:59:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:26 INFO - 'opt_config_files': (), 18:59:26 INFO - 'pip_index': False, 18:59:26 INFO - 'sps_profile': False, 18:59:26 INFO - 'sps_profile_interval': 0, 18:59:26 INFO - 'suite': 'dromaeojs-e10s', 18:59:26 INFO - 'system_bits': '32', 18:59:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:26 INFO - 'title': 'talos-linux64-ix-038', 18:59:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:26 INFO - 'use_talos_json': True, 18:59:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:26 INFO - 'work_dir': 'build'} 18:59:26 INFO - ##### 18:59:26 INFO - ##### Running clobber step. 18:59:26 INFO - ##### 18:59:26 INFO - Running pre-action listener: _resource_record_pre_action 18:59:26 INFO - Running main action method: clobber 18:59:26 INFO - rmtree: /builds/slave/test/build 18:59:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:28 INFO - Running post-action listener: _resource_record_post_action 18:59:28 INFO - ##### 18:59:28 INFO - ##### Running read-buildbot-config step. 18:59:28 INFO - ##### 18:59:28 INFO - Running pre-action listener: _resource_record_pre_action 18:59:28 INFO - Running main action method: read_buildbot_config 18:59:28 INFO - Using buildbot properties: 18:59:28 INFO - { 18:59:28 INFO - "project": "", 18:59:28 INFO - "product": "firefox", 18:59:28 INFO - "script_repo_revision": "production", 18:59:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:59:28 INFO - "repository": "", 18:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:59:28 INFO - "buildid": "20160418163008", 18:59:28 INFO - "pgo_build": "True", 18:59:28 INFO - "basedir": "/builds/slave/test", 18:59:28 INFO - "buildnumber": 185, 18:59:28 INFO - "slavename": "talos-linux64-ix-038", 18:59:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:59:28 INFO - "platform": "ubuntu64_hw", 18:59:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:59:28 INFO - "branch": "mozilla-central", 18:59:28 INFO - "repo_path": "mozilla-central", 18:59:28 INFO - "revision": "67ac40fb8f680ea5e03805552187ba1b5e8392a1", 18:59:28 INFO - "stage_platform": "linux64-pgo", 18:59:28 INFO - "builduid": "af71cc78be7a492ab9ea1f85b2527209", 18:59:28 INFO - "slavebuilddir": "test" 18:59:28 INFO - } 18:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:59:28 INFO - Running post-action listener: _resource_record_post_action 18:59:28 INFO - ##### 18:59:28 INFO - ##### Running download-and-extract step. 18:59:28 INFO - ##### 18:59:28 INFO - Running pre-action listener: _resource_record_pre_action 18:59:28 INFO - Running main action method: download_and_extract 18:59:28 INFO - mkdir: /builds/slave/test/build/tests 18:59: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')]} 18:59:28 INFO - https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:32 INFO - Downloaded 1361 bytes. 18:59:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:59:32 INFO - Using the following test package requirements: 18:59:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:59:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:59:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'jsshell-linux-x86_64.zip'], 18:59:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:59:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:59:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:59:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:59:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:59:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:59: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')]} 18:59:32 INFO - https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:34 INFO - Downloaded 23780756 bytes. 18:59:34 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'] 18:59:34 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 18:59:35 INFO - Return code: 0 18:59:35 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 18:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:35 INFO - https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:38 INFO - Downloaded 23780756 bytes. 18:59:38 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'] 18:59:38 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 18:59:41 INFO - Return code: 0 18:59:41 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')]} 18:59:41 INFO - https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:42 INFO - Downloaded 10845952 bytes. 18:59:42 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'] 18:59:42 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 18:59:43 INFO - Return code: 0 18:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:43 INFO - https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SvZ111VOSHi-8TKXNFGGaA/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 18:59:46 INFO - Downloaded 58251738 bytes. 18:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:47 INFO - mkdir: /builds/slave/test/properties 18:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:47 INFO - Contents: 18:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:59:48 INFO - Running post-action listener: _resource_record_post_action 18:59:48 INFO - Running post-action listener: set_extra_try_arguments 18:59:48 INFO - ##### 18:59:48 INFO - ##### Running populate-webroot step. 18:59:48 INFO - ##### 18:59:48 INFO - Running pre-action listener: _resource_record_pre_action 18:59:48 INFO - Running main action method: populate_webroot 18:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:48 INFO - '--tppagecycles', 18:59:48 INFO - '7'], 18:59:48 INFO - 'tests': ['tsvgm']}}, 18:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['damp', 'tps']}, 18:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'tests': ['damp', 'tps']}, 18:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['dromaeo_dom']}, 18:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['a11yr', 18:59:48 INFO - 'ts_paint', 18:59:48 INFO - 'tpaint', 18:59:48 INFO - 'sessionrestore', 18:59:48 INFO - 'sessionrestore_no_auto_restore', 18:59:48 INFO - 'tabpaint']}, 18:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['tsvgx', 18:59:48 INFO - 'tsvgr_opacity', 18:59:48 INFO - 'tart', 18:59:48 INFO - 'tscrollx', 18:59:48 INFO - 'cart']}, 18:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:48 INFO - 'tsvgr_opacity', 18:59:48 INFO - 'tart', 18:59:48 INFO - 'tscrollx', 18:59:48 INFO - 'cart']}, 18:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'talos_options': ['--disable-e10s'], 18:59:48 INFO - 'tests': ['tp5o']}, 18:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'tests': ['tp5o']}, 18:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'talos_options': ['--disable-e10s', 18:59:48 INFO - '--xperf_path', 18:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:48 INFO - 'tests': ['tp5n']}, 18:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:48 INFO - 'talos_options': ['--xperf_path', 18:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:48 INFO - 'tests': ['tp5n']}}, 18:59:48 INFO - 'talos.zip': {'path': '', 18:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:48 INFO - Running post-action listener: _resource_record_post_action 18:59:48 INFO - ##### 18:59:48 INFO - ##### Running create-virtualenv step. 18:59:48 INFO - ##### 18:59:48 INFO - Running pre-action listener: _resource_record_pre_action 18:59:48 INFO - Running main action method: create_virtualenv 18:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:48 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 18:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:48 INFO - Using real prefix '/usr' 18:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:50 INFO - Installing pip.................done. 18:59:50 INFO - Return code: 0 18:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 18:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:59:50 INFO - Using env: {'DISPLAY': ':0', 18:59:50 INFO - 'HOME': '/home/cltbld', 18:59:50 INFO - 'LANG': 'en_US.UTF-8', 18:59:50 INFO - 'LANGUAGE': 'en_US:en', 18:59:50 INFO - 'LOGNAME': 'cltbld', 18:59:50 INFO - 'MAIL': '/var/mail/cltbld', 18:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:50 INFO - 'MOZ_NO_REMOTE': '1', 18:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:50 INFO - 'NO_EM_RESTART': '1', 18:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:50 INFO - 'PWD': '/builds/slave/test', 18:59:50 INFO - 'SHELL': '/bin/bash', 18:59:50 INFO - 'SHLVL': '1', 18:59:50 INFO - 'TERM': 'linux', 18:59:50 INFO - 'TMOUT': '86400', 18:59:50 INFO - 'USER': 'cltbld', 18:59:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 18:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:50 INFO - '_': '/tools/buildbot/bin/python'} 18:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:51 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 18:59:51 INFO - Cleaning up... 18:59:51 INFO - Return code: 0 18:59:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:51 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 18:59:51 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 18:59:51 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 18:59:51 INFO - Using env: {'DISPLAY': ':0', 18:59:51 INFO - 'HOME': '/home/cltbld', 18:59:51 INFO - 'LANG': 'en_US.UTF-8', 18:59:51 INFO - 'LANGUAGE': 'en_US:en', 18:59:51 INFO - 'LOGNAME': 'cltbld', 18:59:51 INFO - 'MAIL': '/var/mail/cltbld', 18:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:51 INFO - 'MOZ_NO_REMOTE': '1', 18:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:51 INFO - 'NO_EM_RESTART': '1', 18:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:51 INFO - 'PWD': '/builds/slave/test', 18:59:51 INFO - 'SHELL': '/bin/bash', 18:59:51 INFO - 'SHLVL': '1', 18:59:51 INFO - 'TERM': 'linux', 18:59:51 INFO - 'TMOUT': '86400', 18:59:51 INFO - 'USER': 'cltbld', 18:59:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 18:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:51 INFO - '_': '/tools/buildbot/bin/python'} 18:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:51 INFO - Downloading/unpacking psutil>=0.7.1 18:59:51 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 18:59:51 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 18:59:51 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 18:59:51 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 18:59:51 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 18:59:51 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 18:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:53 INFO - Installing collected packages: psutil 18:59:53 INFO - Running setup.py install for psutil 18:59:53 INFO - building 'psutil._psutil_linux' extension 18:59:53 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 18:59:54 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 18:59:54 INFO - building 'psutil._psutil_posix' extension 18:59:54 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 18:59:54 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 18:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:55 INFO - Successfully installed psutil 18:59:55 INFO - Cleaning up... 18:59:55 INFO - Return code: 0 18:59:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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', '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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 18:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:59: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 mozsystemmonitor==0.0.0 18:59:55 INFO - Using env: {'DISPLAY': ':0', 18:59:55 INFO - 'HOME': '/home/cltbld', 18:59:55 INFO - 'LANG': 'en_US.UTF-8', 18:59:55 INFO - 'LANGUAGE': 'en_US:en', 18:59:55 INFO - 'LOGNAME': 'cltbld', 18:59:55 INFO - 'MAIL': '/var/mail/cltbld', 18:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:55 INFO - 'MOZ_NO_REMOTE': '1', 18:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:55 INFO - 'NO_EM_RESTART': '1', 18:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:55 INFO - 'PWD': '/builds/slave/test', 18:59:55 INFO - 'SHELL': '/bin/bash', 18:59:55 INFO - 'SHLVL': '1', 18:59:55 INFO - 'TERM': 'linux', 18:59:55 INFO - 'TMOUT': '86400', 18:59:55 INFO - 'USER': 'cltbld', 18:59:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 18:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:55 INFO - '_': '/tools/buildbot/bin/python'} 18:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:59:57 INFO - Installing collected packages: mozsystemmonitor 18:59:57 INFO - Running setup.py install for mozsystemmonitor 18:59:57 INFO - Successfully installed mozsystemmonitor 18:59:57 INFO - Cleaning up... 18:59:57 INFO - Return code: 0 18:59:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:57 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')]} 18:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:57 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')]} 18:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:57 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 18:59:57 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 18:59:57 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 18:59:57 INFO - Using env: {'DISPLAY': ':0', 18:59:57 INFO - 'HOME': '/home/cltbld', 18:59:57 INFO - 'LANG': 'en_US.UTF-8', 18:59:57 INFO - 'LANGUAGE': 'en_US:en', 18:59:57 INFO - 'LOGNAME': 'cltbld', 18:59:57 INFO - 'MAIL': '/var/mail/cltbld', 18:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:57 INFO - 'MOZ_NO_REMOTE': '1', 18:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:57 INFO - 'NO_EM_RESTART': '1', 18:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:57 INFO - 'PWD': '/builds/slave/test', 18:59:57 INFO - 'SHELL': '/bin/bash', 18:59:57 INFO - 'SHLVL': '1', 18:59:57 INFO - 'TERM': 'linux', 18:59:57 INFO - 'TMOUT': '86400', 18:59:57 INFO - 'USER': 'cltbld', 18:59:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 18:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:57 INFO - '_': '/tools/buildbot/bin/python'} 18:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:57 INFO - Downloading/unpacking blobuploader==1.2.4 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 18:59:59 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 19:00:00 INFO - Downloading docopt-0.6.1.tar.gz 19:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:00 INFO - Running setup.py install for blobuploader 19:00:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:00 INFO - Running setup.py install for requests 19:00:00 INFO - Running setup.py install for docopt 19:00:00 INFO - Successfully installed blobuploader requests docopt 19:00:00 INFO - Cleaning up... 19:00:00 INFO - Return code: 0 19:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:00 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')]} 19:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:00 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')]} 19:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:00 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 19:00:00 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 19:00:00 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 19:00:00 INFO - Using env: {'DISPLAY': ':0', 19:00:00 INFO - 'HOME': '/home/cltbld', 19:00:00 INFO - 'LANG': 'en_US.UTF-8', 19:00:00 INFO - 'LANGUAGE': 'en_US:en', 19:00:00 INFO - 'LOGNAME': 'cltbld', 19:00:00 INFO - 'MAIL': '/var/mail/cltbld', 19:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:00 INFO - 'MOZ_NO_REMOTE': '1', 19:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:00 INFO - 'NO_EM_RESTART': '1', 19:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:00 INFO - 'PWD': '/builds/slave/test', 19:00:00 INFO - 'SHELL': '/bin/bash', 19:00:00 INFO - 'SHLVL': '1', 19:00:00 INFO - 'TERM': 'linux', 19:00:00 INFO - 'TMOUT': '86400', 19:00:00 INFO - 'USER': 'cltbld', 19:00:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:00 INFO - '_': '/tools/buildbot/bin/python'} 19:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:01 INFO - Running setup.py (path:/tmp/pip-yvkSYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:01 INFO - Running setup.py (path:/tmp/pip-xJkium-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:01 INFO - Running setup.py (path:/tmp/pip-ZGckqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:01 INFO - Running setup.py (path:/tmp/pip-wqoARx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:01 INFO - Running setup.py (path:/tmp/pip-tpRyYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:01 INFO - Running setup.py (path:/tmp/pip-UJ67Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:01 INFO - Running setup.py (path:/tmp/pip-AGpHuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:01 INFO - Running setup.py (path:/tmp/pip-yxt9Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:01 INFO - Running setup.py (path:/tmp/pip-wm3ni7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:01 INFO - Running setup.py (path:/tmp/pip-owpLCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:01 INFO - Running setup.py (path:/tmp/pip-PhRNzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:01 INFO - Running setup.py (path:/tmp/pip-SDxIhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:01 INFO - Running setup.py (path:/tmp/pip-jP6SG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:02 INFO - Running setup.py (path:/tmp/pip-JFWk5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:02 INFO - Running setup.py (path:/tmp/pip-WOiyeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:02 INFO - Running setup.py (path:/tmp/pip-Zd0GBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:02 INFO - Running setup.py (path:/tmp/pip-WQYKQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:02 INFO - Running setup.py install for manifestparser 19:00:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozcrash 19:00:02 INFO - Running setup.py install for mozdebug 19:00:02 INFO - Running setup.py install for mozdevice 19:00:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozfile 19:00:02 INFO - Running setup.py install for mozhttpd 19:00:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozinfo 19:00:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozInstall 19:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozleak 19:00:03 INFO - Running setup.py install for mozlog 19:00:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for moznetwork 19:00:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozprocess 19:00:03 INFO - Running setup.py install for mozprofile 19:00:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozrunner 19:00:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozscreenshot 19:00:03 INFO - Running setup.py install for moztest 19:00:03 INFO - Running setup.py install for mozversion 19:00:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:04 INFO - Cleaning up... 19:00:04 INFO - Return code: 0 19:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:04 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')]} 19:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 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')]} 19:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 19:00:04 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 19:00:04 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 19:00:04 INFO - Using env: {'DISPLAY': ':0', 19:00:04 INFO - 'HOME': '/home/cltbld', 19:00:04 INFO - 'LANG': 'en_US.UTF-8', 19:00:04 INFO - 'LANGUAGE': 'en_US:en', 19:00:04 INFO - 'LOGNAME': 'cltbld', 19:00:04 INFO - 'MAIL': '/var/mail/cltbld', 19:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:04 INFO - 'MOZ_NO_REMOTE': '1', 19:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:04 INFO - 'NO_EM_RESTART': '1', 19:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:04 INFO - 'PWD': '/builds/slave/test', 19:00:04 INFO - 'SHELL': '/bin/bash', 19:00:04 INFO - 'SHLVL': '1', 19:00:04 INFO - 'TERM': 'linux', 19:00:04 INFO - 'TMOUT': '86400', 19:00:04 INFO - 'USER': 'cltbld', 19:00:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:04 INFO - '_': '/tools/buildbot/bin/python'} 19:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:04 INFO - Running setup.py (path:/tmp/pip-CCpYR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:04 INFO - Running setup.py (path:/tmp/pip-JkANVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:04 INFO - Running setup.py (path:/tmp/pip-MHxGng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:04 INFO - Running setup.py (path:/tmp/pip-dovArW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:04 INFO - Running setup.py (path:/tmp/pip-Evt5JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:04 INFO - Running setup.py (path:/tmp/pip-YxQ9XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:04 INFO - Running setup.py (path:/tmp/pip-iKIy18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:04 INFO - Running setup.py (path:/tmp/pip-rIINWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:04 INFO - Running setup.py (path:/tmp/pip-3K4pp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:04 INFO - Running setup.py (path:/tmp/pip-mlrUI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:04 INFO - Running setup.py (path:/tmp/pip-RaH96G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:05 INFO - Running setup.py (path:/tmp/pip-EJV4VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:05 INFO - Running setup.py (path:/tmp/pip-18sTCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:05 INFO - Running setup.py (path:/tmp/pip-IqHIrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:05 INFO - Running setup.py (path:/tmp/pip-2x1hLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:05 INFO - Running setup.py (path:/tmp/pip-9wwptZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:05 INFO - Running setup.py (path:/tmp/pip-c_xZ_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:07 INFO - Downloading blessings-1.6.tar.gz 19:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:07 INFO - Installing collected packages: blessings 19:00:07 INFO - Running setup.py install for blessings 19:00:07 INFO - Successfully installed blessings 19:00:07 INFO - Cleaning up... 19:00:07 INFO - Return code: 0 19:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:07 INFO - Reading from file tmpfile_stdout 19:00:07 INFO - Current package versions: 19:00:07 INFO - argparse == 1.2.1 19:00:07 INFO - blessings == 1.6 19:00:07 INFO - blobuploader == 1.2.4 19:00:07 INFO - docopt == 0.6.1 19:00:07 INFO - manifestparser == 1.1 19:00:07 INFO - mozInstall == 1.12 19:00:07 INFO - mozcrash == 0.17 19:00:07 INFO - mozdebug == 0.1 19:00:07 INFO - mozdevice == 0.48 19:00:07 INFO - mozfile == 1.2 19:00:07 INFO - mozhttpd == 0.7 19:00:07 INFO - mozinfo == 0.9 19:00:07 INFO - mozleak == 0.1 19:00:07 INFO - mozlog == 3.1 19:00:07 INFO - moznetwork == 0.27 19:00:07 INFO - mozprocess == 0.22 19:00:07 INFO - mozprofile == 0.28 19:00:07 INFO - mozrunner == 6.11 19:00:07 INFO - mozscreenshot == 0.1 19:00:07 INFO - mozsystemmonitor == 0.0 19:00:07 INFO - moztest == 0.7 19:00:07 INFO - mozversion == 1.4 19:00:07 INFO - psutil == 3.1.1 19:00:07 INFO - requests == 1.2.3 19:00:07 INFO - wsgiref == 0.1.2 19:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 19:00:07 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 19:00:07 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 19:00:07 INFO - Using env: {'DISPLAY': ':0', 19:00:07 INFO - 'HOME': '/home/cltbld', 19:00:07 INFO - 'LANG': 'en_US.UTF-8', 19:00:07 INFO - 'LANGUAGE': 'en_US:en', 19:00:07 INFO - 'LOGNAME': 'cltbld', 19:00:07 INFO - 'MAIL': '/var/mail/cltbld', 19:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:07 INFO - 'MOZ_NO_REMOTE': '1', 19:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:07 INFO - 'NO_EM_RESTART': '1', 19:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:07 INFO - 'PWD': '/builds/slave/test', 19:00:07 INFO - 'SHELL': '/bin/bash', 19:00:07 INFO - 'SHLVL': '1', 19:00:07 INFO - 'TERM': 'linux', 19:00:07 INFO - 'TMOUT': '86400', 19:00:07 INFO - 'USER': 'cltbld', 19:00:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:07 INFO - '_': '/tools/buildbot/bin/python'} 19:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 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)) 19:00:08 INFO - Cleaning up... 19:00:08 INFO - Return code: 0 19:00:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:08 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')]} 19:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:08 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')]} 19:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:08 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 19:00:08 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 19:00:08 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 19:00:08 INFO - Using env: {'DISPLAY': ':0', 19:00:08 INFO - 'HOME': '/home/cltbld', 19:00:08 INFO - 'LANG': 'en_US.UTF-8', 19:00:08 INFO - 'LANGUAGE': 'en_US:en', 19:00:08 INFO - 'LOGNAME': 'cltbld', 19:00:08 INFO - 'MAIL': '/var/mail/cltbld', 19:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:08 INFO - 'MOZ_NO_REMOTE': '1', 19:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:08 INFO - 'NO_EM_RESTART': '1', 19:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:08 INFO - 'PWD': '/builds/slave/test', 19:00:08 INFO - 'SHELL': '/bin/bash', 19:00:08 INFO - 'SHLVL': '1', 19:00:08 INFO - 'TERM': 'linux', 19:00:08 INFO - 'TMOUT': '86400', 19:00:08 INFO - 'USER': 'cltbld', 19:00:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:08 INFO - '_': '/tools/buildbot/bin/python'} 19:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:08 INFO - Downloading/unpacking jsonschema 19:00:08 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 19:00:08 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 19:00:08 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 19:00:08 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 19:00:08 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 19:00:08 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 19:00:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:10 INFO - Downloading/unpacking functools32 (from jsonschema) 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:10 INFO - warning: no files found matching '*.txt' 19:00:10 INFO - no previously-included directories found matching 'build' 19:00:10 INFO - no previously-included directories found matching 'dist' 19:00:10 INFO - no previously-included directories found matching '.git*' 19:00:10 INFO - Installing collected packages: jsonschema, functools32 19:00:10 INFO - Running setup.py install for functools32 19:00:10 INFO - warning: no files found matching '*.txt' 19:00:10 INFO - no previously-included directories found matching 'build' 19:00:10 INFO - no previously-included directories found matching 'dist' 19:00:10 INFO - no previously-included directories found matching '.git*' 19:00:10 INFO - Successfully installed jsonschema functools32 19:00:10 INFO - Cleaning up... 19:00:10 INFO - Return code: 0 19:00:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 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 0x7feb2f52ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, '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': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', '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 19:00:10 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 19:00:10 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 19:00:10 INFO - Using env: {'DISPLAY': ':0', 19:00:10 INFO - 'HOME': '/home/cltbld', 19:00:10 INFO - 'LANG': 'en_US.UTF-8', 19:00:10 INFO - 'LANGUAGE': 'en_US:en', 19:00:10 INFO - 'LOGNAME': 'cltbld', 19:00:10 INFO - 'MAIL': '/var/mail/cltbld', 19:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:10 INFO - 'MOZ_NO_REMOTE': '1', 19:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:10 INFO - 'NO_EM_RESTART': '1', 19:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:10 INFO - 'PWD': '/builds/slave/test', 19:00:10 INFO - 'SHELL': '/bin/bash', 19:00:10 INFO - 'SHLVL': '1', 19:00:10 INFO - 'TERM': 'linux', 19:00:10 INFO - 'TMOUT': '86400', 19:00:10 INFO - 'USER': 'cltbld', 19:00:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:10 INFO - '_': '/tools/buildbot/bin/python'} 19:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:10 INFO - Downloading/unpacking flake8 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:10 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 19:00:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:00:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:00:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:12 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 19:00:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:00:13 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 19:00:13 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 19:00:13 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 19:00:13 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 19:00:13 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 19:00:13 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 19:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:13 INFO - no previously-included directories found matching 'docs/_build' 19:00:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:00:13 INFO - Running setup.py install for pep8 19:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:13 INFO - no previously-included directories found matching 'docs/_build' 19:00:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:00:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:00:13 INFO - Cleaning up... 19:00:13 INFO - Return code: 0 19:00:13 INFO - Running post-action listener: _resource_record_post_action 19:00:13 INFO - Running post-action listener: _start_resource_monitoring 19:00:13 INFO - Starting resource monitoring. 19:00:13 INFO - ##### 19:00:13 INFO - ##### Running install step. 19:00:13 INFO - ##### 19:00:13 INFO - Running pre-action listener: _resource_record_pre_action 19:00:13 INFO - Running main action method: install 19:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:13 INFO - Reading from file tmpfile_stdout 19:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:14 INFO - Reading from file tmpfile_stdout 19:00:14 INFO - Output received: 19:00:14 INFO - Usage: mozinstall [options] installer 19:00:14 INFO - Options: 19:00:14 INFO - -h, --help show this help message and exit 19:00:14 INFO - -d DEST, --destination=DEST 19:00:14 INFO - Directory to install application into. [default: 19:00:14 INFO - "/builds/slave/test"] 19:00:14 INFO - --app=APP Application being installed. [default: firefox] 19:00:14 INFO - mkdir: /builds/slave/test/build/application 19:00:14 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'] 19:00:14 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 19:00:30 INFO - Reading from file tmpfile_stdout 19:00:30 INFO - Output received: 19:00:30 INFO - /builds/slave/test/build/application/firefox/firefox 19:00:30 INFO - Running post-action listener: _resource_record_post_action 19:00:30 INFO - ##### 19:00:30 INFO - ##### Running run-tests step. 19:00:30 INFO - ##### 19:00:30 INFO - Running pre-action listener: _resource_record_pre_action 19:00:30 INFO - Running main action method: run_tests 19:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:30 INFO - Python 2.7.3 19:00:30 INFO - Return code: 0 19:00:30 INFO - grabbing minidump binary from tooltool 19:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:30 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 0x1d71410>, '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 0x1d72310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d727a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:30 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 19:00:30 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 19:00:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:30 INFO - Return code: 0 19:00:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:00:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:00:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:00:31 INFO - Return code: 0 19:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 19:00:31 INFO - Using env: {'DISPLAY': ':0', 19:00:31 INFO - 'HOME': '/home/cltbld', 19:00:31 INFO - 'LANG': 'en_US.UTF-8', 19:00:31 INFO - 'LANGUAGE': 'en_US:en', 19:00:31 INFO - 'LOGNAME': 'cltbld', 19:00:31 INFO - 'MAIL': '/var/mail/cltbld', 19:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:31 INFO - 'MOZ_NO_REMOTE': '1', 19:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:31 INFO - 'NO_EM_RESTART': '1', 19:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:31 INFO - 'PWD': '/builds/slave/test', 19:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:31 INFO - 'SHELL': '/bin/bash', 19:00:31 INFO - 'SHLVL': '1', 19:00:31 INFO - 'TERM': 'linux', 19:00:31 INFO - 'TMOUT': '86400', 19:00:31 INFO - 'USER': 'cltbld', 19:00:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610', 19:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:31 INFO - '_': '/tools/buildbot/bin/python'} 19:00:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 19:00:32 INFO - mozversion application_buildid: 20160418163008 19:00:32 INFO - mozversion application_changeset: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 19:00:32 INFO - mozversion application_display_name: Nightly 19:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:32 INFO - mozversion application_name: Firefox 19:00:32 INFO - mozversion application_remotingname: firefox 19:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:32 INFO - mozversion application_vendor: Mozilla 19:00:32 INFO - mozversion application_version: 48.0a1 19:00:32 INFO - mozversion platform_buildid: 20160418163008 19:00:32 INFO - mozversion platform_changeset: 67ac40fb8f680ea5e03805552187ba1b5e8392a1 19:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:32 INFO - mozversion platform_version: 48.0a1 19:00:32 INFO - using testdate: 1461031232 19:00:32 INFO - actual date: 1461031232 19:00:32 INFO - starting webserver on 'localhost:55289' 19:00:32 INFO - SUITE-START | Running 2 tests 19:00:32 INFO - TEST-START | dromaeo_css 19:00:32 INFO - operating with platform_type : linux_ 19:00:32 INFO - Initialising browser for dromaeo_css test... 19:00:32 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsD439/profile http://localhost:55289/getInfo.html) 19:00:39 INFO - PROCESS | 3301 | 19:00:39 INFO - PROCESS | 3301 | (process:3370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:40 INFO - PROCESS | 3301 | __metrics Screen width/height:1600/1200 19:00:40 INFO - PROCESS | 3301 | colorDepth:24 19:00:40 INFO - PROCESS | 3301 | Browser inner width/height: 1024/697 19:00:40 INFO - PROCESS | 3301 | __metrics 19:00:41 ERROR - PROCESS | 3301 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:00:42 INFO - TEST-INFO | 3301: exit 0 19:00:42 INFO - Browser initialized. 19:00:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:42 INFO - TEST-INFO | started process 3421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsD439/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:44 INFO - PROCESS | 3421 | 19:00:44 INFO - PROCESS | 3421 | (process:3480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:54 INFO - PROCESS | 3421 | RSS: Main: 163692544 19:00:54 INFO - PROCESS | 3421 | 19:01:43 INFO - PROCESS | 3421 | 1461031303616 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] 19:03:50 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55289/tests/dromaeo/cssquery-ext.html) 19:03:51 INFO - PROCESS | 3421 | RSS: Main: 168288256 19:03:51 INFO - PROCESS | 3421 | 19:06:53 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-ext.html (next: http://localhost:55289/tests/dromaeo/cssquery-jquery.html) 19:06:54 INFO - PROCESS | 3421 | RSS: Main: 165134336 19:06:54 INFO - PROCESS | 3421 | 19:09:55 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55289/tests/dromaeo/cssquery-mootools.html) 19:09:56 INFO - PROCESS | 3421 | RSS: Main: 166121472 19:09:56 INFO - PROCESS | 3421 | 19:12:58 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55289/tests/dromaeo/cssquery-prototype.html) 19:12:58 INFO - PROCESS | 3421 | RSS: Main: 163454976 19:12:58 INFO - PROCESS | 3421 | 19:16:01 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55289/tests/dromaeo/cssquery-yui.html) 19:16:01 INFO - PROCESS | 3421 | RSS: Main: 165183488 19:16:01 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:55289/tests/dromaeo/cssquery-yui.html (next: http://localhost:55289/tests/dromaeo/cssquery-dojo.html) 19:19:04 INFO - PROCESS | 3421 | RSS: Main: 166895616 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | __start_tp_report 19:19:04 INFO - PROCESS | 3421 | _x_x_mozilla_page_load 19:19:04 INFO - PROCESS | 3421 | _x_x_mozilla_page_load_details 19:19:04 INFO - PROCESS | 3421 | |i|pagename|runs| 19:19:04 INFO - PROCESS | 3421 | |0;dojo.html;3117.8441077946095;3138.780285380023;3138.952915706265;3179.8728050877953;3190.7447404207664;5338.665333666583;5341.839744807652;5345.7594408251725;5366.114591092465;5415.241866138739;5305.814296499623;5340.465953404658;5361.919571206426;5428.4842939920745;5549.0289199390145;4864.221724524077;4904.337914381566;4970.552650261476;4988.401391832967;5038.2190760432;506.03713143342367;4816.988432429194;4840.298156767267;4856.150173719585;4895.485973972735;4840;4842.709437433748;4855.8057677693205;4863.635227357962;4904.411470623512;4858.489858564835;4922.876928076791;4935.284383764334;4945.7774400152075;4987.975060124712;4840.322354870321;4874.780634871439;4879.829205977774;4884.731339776311;4921.876953076166;5306;5328.120860058086;5349.029945381392;5365.3293338332705;5370.382406023318;5594.9720251398885;5695.487406133468;5749.367569567345;5797.710114494301;5799.594028418012;5666.660000399989;5722.284714410699;5740.971295143498;5782.681952492611;5791.768329266866;5346.545543628797;5355.223492593552;5356.089464790956;5366.838994830161;5391.973040134813;5684.658920464785;5861.238039054938;5892.793752218652;5893.970530147408;5898.262717160355;5665.348484924287;5723.399043100498;5726.398728133569;5730.36965933747;5775.162601422854;5720.77116915327;5745.195672605839;5745.482906538432;5752.165935939349;5753.884922301614;5564.221009058735;5655.802046928337;5737.254156959569;5739.971300143473;5753.194552762617;5702.7433765480655;5734.426557344315;5786.276715410574;5792.652440853562;5805;4337.978310108492;4352.455943007124;4363.694541382073;4369.235383807821;4412.713173643703;3868.0716628009077;3887.4168874669026;3908.7654740715648;3918.392649139388;3935.2916475034194;5389.946100539023;5400.027994960945;5409.053415652245;5411.404745477994;5456.990456765511;5695.117256825199;5712.400197979152;5755.740991655385;5774.393688662714;5777.19119323295;5356.223347614574;5387.111126664056;5403.2165336026055;5419.647722897999;5517.172424136412;4963.925541116886;4969.975150124226;4981.427135879348;4998.775055122528;5018.974905125524;5937.554683398763;5942.197803296586;5995.640261584319;5996.2504686914135;6039.365866584033;5719.828405147936;5783.566232532493;5858.121281807763;5865.970670146622;5881.32364778056;5915.260592425947;5947.613405128825;5949;5951.315598706031;5958.523318134626;5649.802256920988;5693.601447898773;5695.088785794253;5695.345035320991;5707.571932105026;5525.613207075467;5767.307923049261;5811.186433899342;5834.03738383162;5857.677827719346;5634.6337488063145;5647.435256474319;5668.51817595509;5669.036263835241;5679.886402271849;5419.945800542102;5611.410801865745;5673.404292549388;5674.4892959633835;5676.17695434168;5394.083005889087;5467.890642187213;5549.389567147691;5564.944350556604;5580.162975553537;5608.971955140199;5632.971835140798;5637.126245431965;5663.122216056518;5723.055695810144;5556.749946252347;5559.19391688211;5561.555075594024;5593.468620481048;5606.327240731139 19:19:04 INFO - PROCESS | 3421 | |1;ext.html;607.8996965500693;638.3265654734254;640.8782331357041;651.6481100205889;654.4273760459598;29582.704172958263;37672.623273767254;38160.809195954054;38241.85274441768;38349.61650383495;39699.20601587967;39811.60188398115;40239;40320;40353.19293614126;8395.706150284726;8491.787705307386;8637.827243455158;8646.567671616425;8682.565871706389;8497;8615.569221538897;8619.95690021549;8637.956810215941;8900.73297801067;8926.642934282654;8997.730068097968;9004.504752238625;9005.099490051009;9031.23234525066;8880.689175878846;8916.777080573038;8942.73171804847;8948.821023579558;8963.148500892405;8755.956220218923;8911.287097032222;8918.331125165638;8919.152680495343;8922.152395522415;39815.80092099521;40012.59987400118;40169.99575010648;40184.59815401867;40255;3546.92042038312;3683.852645894161;3809.885703428874;3833.0936401405966;4156.501219853637;30631.81842964851;30983.380332393226;31003.22491937697;31013.0696079118;31338;4350.673699472521;4358.4987726411555;4425.889352766175;4441.733495990251;4537.77311134442;215664;215735;215949.99999999843;216677;216717;34748;35852.64147358545;35853.46219806705;57182;58684.41315586789;34435.31129377449;34573.827130864185;34699;34706.305873882884;34720.26398680056;14983;15049.473268435551;15154.696906061818;15260.542183734506;15323.23383830804;12361.814572781415;12445.066620003536;12456.190347627375;12485.563005294953;12513.249205047727;8266.710665126691;8301.626426810808;8322.417430779908;8349.749507514784;8399.664013439395;3230.1601583588435;3237;3279.967200328014;3299.686529779667;3307.9834600826844;1070.4594179939081;1082.8917108289108;1096.331237944853;1187.424099311833;1201.2012012011915;31677.683223167933;32054.83972580169;32164.35671286561;32567.51148732771;32766.672333276838;1139.1797905508022;1141.3494308244387;1152.3086148310947;1197.7724232395817;1261.5710658376197;16550.144289411845;16969;16982.32070717182;16997.49007529776;17445.825541744674;463219;471920.1231950752;473102;473145;474202;57233;57320;57609;57746.13380799291;57778.7111064442;1367.8837298829512;1388.8055672205899;1389.5067251125906;1401.8948578856628;1424.9358778854976;31161;31771.682283176873;32178.35643287168;32301.676983229867;33298.833505832314;51817.48182518127;51932;52127;52425;52656.736716316176;414522;418399;420778;420892;420922;28053.85973070203;28122.85938570376;28257.717422826332;28315;43390.783046084565;46304.76847615875;46380.53619463762;46530.30204547002;46701.53298466972;46920.29619555778;38281.23437531178;39532;39605.2078958425;39731.40402894017;39991.400128997506;39684.801575991936;39730.60269397269;40360.59639403686;40461.59538404578;40733.38899916563;39746.40380394354;41738.37392439055;42603.786981066136;43076.35385469283;43413.348799767395;34709.47935780915;36406.27187456183;36797.44803827891;36812.44781328336;36962.44556331711;26168;26910.32724181911;26918.865405672845;27103.45793084167;27523.86238068797 19:19:04 INFO - PROCESS | 3421 | |2;jquery.html;388.097672910483;392.89981054831014;396.6232079524452;400.39740191012527;404.8805602347309;13838.792418113711;17604;18071.4578562643;18346.357877474275;18402.447926562192;16994.320227190896;17076.14619269038;17326.48020559382;18068.90965545174;18133.90933045333;5039.899202015958;5327.121025030865;5338.91991620126;5493.807716729925;5708.8858222835515;3681.355762741523;5257.76340064698;5315.627906046579;5364.195370694408;5550.417206193352;5550.4449555044575;5552.805651802188;5568.916466253009;5585.888282234373;5604.215409842625;5562.276904002474;5654.6041777075625;6149.907751383733;6156.045812899008;6170.96914515429;5407.242985981966;5432.103702889019;5433.1035379162395;5434.701091439969;5450.863728406782;11437.771244575062;11872;11905.761884762343;12015.759684806255;12051.096167787451;2106.378618307603;2179.716636837217;2184.923527676524;2255.9210427635117;2340.021962663462;9247.907520924771;9573.569189386495;9590.76023099421;9663.26061308964;9978.750531236705;1855.5732181598173;1902.80020597838;1909.9331523396754;1909.9522511937173;1925.4403932814464;76530;80087.19912800856;80578.59710701468;80927;81858.59070704668;10394.16846652266;10551.261411701107;10693.625723099654;10719.517621707042;10800.567977280978;12625.747485050248;13079;14891.851081489047;14966.02720823143;14968.251587420804;5896.498797602252;6069.848253793691;6835.521513494008;7681.923180768233;7796.220377962159;7228.638568071576;7499.8500029999095;7506.962465187639;7551.207123252089;7574.469787114959;4187.874363769091;4318.676099292566;4561.589456948825;4571.131485017836;4676.298555216745;1821.1713670279992;1860.9627807443776;1889.6787546117193;1930.845532357408;1938.4959910423393;950.3680052764972;1000.4497526360618;1074.9948797874013;1106.590561492253;1137.147139645266;17194.914025429793;17594.91202543979;17696.93818370902;17721.202545885208;18161.545961351072;1000.1648623399398;1045.6915210013065;1068.5351871935577;1070.6359837655234;1096.9396683182342;9429.528523573794;10022.448765317831;10123.696289111338;10233.385996840214;10301.74245643865;527627;559322;574060.0698440253;582631;583675;93166;97815;98285;98490;98699.50650246703;1021.9795604087876;1082.983755243672;1092.6230450494568;1094.8467214589964;1097.3964319624333;16259.837401625833;16260.186990650183;16327;16333.836661633231;16607.50177494677;37538;37718.8114059428;37842.243155136195;39768;40507.59492405038;52826.47173528215;54833.72583137059;55024.44975550193;55382.72308638431;55657;7119.928800711927;7362.153352364332;7487.2138425464545;8003.07964584057;8105.716299929474;8811.33914956368;11322.886771132513;11997.220180688228;12179.512819487121;12522.561710340095;7880.448368614142;11123.165762568002;11420.657380278604;11429.542818287508;11494.482748276514;7173.390261827803;7411.629418528944;7629.198934112061;7636;7857.4499785014505;7841.411894108079;8036.437449378721;8249.340052795642;8260.380471464545;8515.19105684959;12140.271583705005;12316.261024338568;12503.749925001632;12571.1200215984;12711.42798574085;12079.094067945114;12349.135560510678;12402.25586464815;12470.5011799527;12633 19:19:04 INFO - PROCESS | 3421 | |3;mootools.html;1428.4286285485805;1481.03732573827;1571.7092337917486;1725.5513566472714;1755.9552066520416;7546.4340174487;7920.801979950504;7922.643481043352;8185.3042491388305;8203.138670439599;7968.482048666832;7997.800054998628;8020.037595488535;8024.398170137234;8088.31249343805;2294.827887908401;2327.208749025331;2337.357226762637;2337.4273303040777;2339.4853132310864;2261.9660705089436;2266.9886650566723;2292.6790249365104;2295.426143464134;2299.540091981602;2253.4479052632128;2285.108807565051;2300.907963681451;2338.0647740903605;2341.66045923341;2140.3364956863265;2164.5238047629496;2173.119886445992;2177.1835561664457;2179.2917301876873;2095.19335056003;2108.1778106538463;2109.156337465011;2116.153538584563;2124.7450305963384;8062.153473885216;8112.513249205066;8196.67213311467;8210.096889342167;8236.176382361777;4989.950100498985;5112.4120726116225;5133.512316329943;5138.58891288696;5152.330197074356;3104.518799586068;3120.719135277836;3181.3796309719614;3218.09893229896;3221;1045.8326667733202;1051.9579216831316;1052.5894900988621;1052.9894701052967;1059.0534150743597;11274.267172633752;11295.378754168518;11314.660560183125;11325.490352934137;11336.433178341133;4287.785610719451;4310.267254566731;4449.555044495589;4475.619572336323;4494.505604383515;9694.854577181348;9711;9738.220942324597;9751.804963900824;9766.9023309766;5127.256547800548;5139.100657384943;5149.76826042829;5153.2270159476375;5158.819441319536;4262.104957958863;4669.673122881366;4700.7179569225955;4707.458642256184;4747.0505898820375;3757.5678796938155;3765.1340191755503;3803.3154032274456;3817.6182381762155;3897.5517815451585;1196.21050106929;1227.0796902323257;1232.9260244385366;1240.231056744824;1249.2442072545978;915.5330781301584;1019.5106348952396;1022.1362948308667;1027.5889644142253;1028.1466382902174;5756.0502517084215;5849.298084229835;5873.089671100986;5889.38161493037;6060.787872424444;445.7904784751162;446.1011062708645;448.5716141085256;1017.3438132404706;1055.134789472625;4096.56986016464;4112.3420252759415;4162.41726158338;4210.368444733314;4222.303319952173;9858.260630452745;10262.230332725076;10356;10360.740981475523;10474.371537707762;10295.970402959643;10332.328398654063;10352.741181470523;10420.843687344695;10438.164946804238;7715.92284077152;7856.489328193764;7862.646180921873;7879.487833290817;7900.4074694397;5518.641288316247;5796.21751063601;5813.593048486566;5821.94178058214;5924;9316.95341523288;9585.233181345615;9588.760280992752;9591.088846559565;9600.519974001132;9319.580618872302;9474.905250947402;9815.803683926139;9908.504574771378;9921;6478.676066196577;6732.158480189976;6782.457403407814;6858.759943401957;6960.129983752031;7790.727324543614;7853.214678532101;7874.72438464651;7930.682772689028;7940.404469664682;7054.329838665319;7118.572885626879;7204.063471748639;7267.273272672691;7442.404607631484;7136.250693677089;7183.066201393785;7198.8920166198595;7258.845251758986;7336.559806411632;6616.2391324996315;6618.371254730793;6630.9336906630315;6651.501137414616;6681.1314529110905;4920.237363208708;4924.901501970012;4945.604351651931;5302.098643230737;5305.257263983122;5154.098032844162;5175.171972484384;5210;5228.581713462838;5272.7100009499845 19:19:04 INFO - PROCESS | 3421 | |4;prototype.html;296.59662858512417;315.48260852202384;316.1795141607528;316.39410528837266;322.66926400439553;5851.122331650244;5882.911756323659;5976.402359764027;6051.667158306292;6106.961816491196;5931.199288096106;5996.850078748033;6002.369751176118;6008.939910600892;6023.728932198051;4507.414036175309;4523.547645235475;4533.773311334437;4533.8413155539565;4540.7502587357685;4433.113377324532;4544.204764166274;4553.290791978784;4600.5629465200755;4622.676412651116;4542.295944128666;4543.114092751898;4550.817967281305;4571.47428045774;4587.908241835161;4574.656900732425;4576.588107070363;4586.403767510219;4591.586757191869;4594.379758732562;3658.396364599838;3851.788151651658;3874.1864208516245;4000.6199411055904;4003.939940900889;5698.971505142489;5730.68481233532;5746.683932383718;5759.1937128802;5777.913331300034;5109.565686916617;5144;5170.922436163461;5178.611604129667;5182.714950677711;5942.910856337158;6282.685865706696;6290.968545157245;6315.97888675624;6332.398422149934;4257.361395790656;4286.57134286572;4287.785610719451;4290.377895205209;4296.140771845643;6369.649669268142;6507.414332710032;6509.1863517060365;6563.638999855006;6582.670866456706;4344;4361.956380436155;4366.519682834885;4368;4377.824887004548;4428.357888106207;4435.35687325336;4438.201123797748;4442.778985235743;4447.421835161408;5053.729598489271;5179.8446046618665;5191.195364718475;5192.792288308501;5202.453742357074;6132.2947860996555;6195.845103872439;6265.937340626627;6361.61830290184;6380.457661098766;1490.3368001239562;1508.2684897824765;1514.5834895403852;1516.9772453412986;1527.9770803437957;994.3586386780486;1001.379144930148;1001.4692213127055;1014.7158795537262;1020.3418794877263;6034.879302414015;6049.153118563405;6053.969730151321;6054.303755068224;6058.394160583906;6495.420728386476;6523.902141467882;6531.771388001397;6552.6068435894;6555.3772391622715;5912.586118971717;6040.395960403925;6087.421694938974;6112.297085835097;6112.694365281718;3468.5317482140094;3484.651534846546;3491.1621210909707;3512.3853325668415;3512.9121771955392;6514.967425162844;6666.300038495888;6681.398674119256;6691.895837186809;6739.191297044386;6599.505037122235;6613.636250006296;6616.206055273398;6639.136912201479;6722.092517510074;6493.740250390026;6639.966800165968;6648.800535983928;6651.66741662915;6656.5340426169705;6476.417122459001;6493.318201588954;6510.609363438209;6514.902276465951;6544.411003009752;6247.7823920679975;6428.935710642833;6430.967845160932;6470.450011749054;6481.092647029325;6686.930091185582;6687.297833727389;6692.89567221403;6696.062551242927;6699.866002680016;4311.762853043113;4325.15659446405;4352.260115780388;4366.65066794662;4377.3871657967275;6276.968615156895;6346.4605508532295;6424.229092508929;6549.443297319781;6601.306862779339;6407.391297826699;6441;6452.35476452351;6460;6472.579282346633;6216.160818289473;6381.489480841615;6395.392437718409;6423.229212494531;6427.517936154901;6234.189555357956;6245.7189426476825;6250.562460627894;6251.312355640966;6282.654454005074;6453.290138084713;6454.934935735551;6461.483081353575;6463.57986730861;6468.450181734605;6019;6248.4376406123665;6342.175517182736;6343.143675603735;6376.353813167483 19:19:04 INFO - PROCESS | 3421 | |5;yui.html;748.3377211168118;770.7918861907285;787.4723934963574;790.3124281874769;797.151034148632;13575.456981720732;13836.584902452918;13985.860141398583;14563.490277840277;14587.927060364684;13398.062135650509;13402.798958015637;13412.664683382896;13444.596662100128;13471.124376915493;675.797260821754;784.3725019984018;791.2878409431514;806.173671986213;810.7608255564593;798.1260519730886;802.7350974178507;811.5455345006785;813.9389545784061;815.4577206157898;832.5961908474385;833.5623797506328;836.2515548584014;836.6862426590029;837.3803385494721;823.0329362998513;825.4964471672275;830.2320353672859;831.476170012894;834.3742193354984;606.8755905039457;608.8325710429623;611.1901730207449;615.9753609855601;617.3764497857196;13804.447822087104;13898.305084745722;13903;13943.302834858216;13946.16323020622;13551.864481355158;13707.177569345871;13712.65718357039;13733.176009439365;13751.656208594764;10932.344059356385;10943.945280273547;10970.341779493176;10984.890151098467;11262.943685281603;3790.8673196438267;3791.6018818024263;3845.057960799594;3882.4758657581147;3963.6036396360423;52218.738906305225;52723.736381317845;52918.206226906244;53050.46949530494;53108.73445632786;10192.388456692623;10338.948305258577;10374.636887708893;10650.360978341325;11507.654770356903;19683.901580492005;19692;19713.408597741804;19717.408477745692;19771.01144942747;8059.838803223903;8110.878336824952;8122.593870306579;8358.498490090615;8502.659893604186;4698.8120475181295;4722.268048452495;4743.02767932573;4787.784549695272;4856.514348565115;3039.878404863781;3128.2804954860508;3140.3248301615263;3144.8742050317733;3152.6689697581883;608.4523928464329;611.6055144431906;615.7783198048699;618.6968385491077;622.0731110645197;625.7590827531342;703.2159142556013;705.5343473307593;706.5795851468368;724.905762250904;8545.74362769118;8597.269232115215;8783.956080219557;8940;9223.907760922439;592.520058752412;679.8504329047602;709.4537206351081;718.3606590134784;737.3916518871952;4150.294449943517;4275.508316543575;4292.12011537634;4296.419983302277;4395.846145384896;50175.49824501708;51685.7415712919;63828;64460.03309950355;64771;48635.75682121567;49378.259326110136;50767.74616126896;51529.22706159411;51547.48452515502;46392.304115438295;46513.06973860504;46564;46671.29993050175;48239.51760482421;7836.451448398558;7881.921180788118;7891.723789667334;8048.5793537747395;8287.792805179919;29021.7097829019;29048.419031619673;29484.852575736983;29658.703412965595;31535.84232078917;43492;44112.33831492466;45241.773791130836;45605.08789824119;45630.54369456263;11619.128565357802;11828.763424731285;11880.821787673365;12010.039196864054;12117.939410302892;11854.229475084092;12103.878961210276;12172.634820955385;12570.622881313575;12624.305663188612;12282.385880706108;12470.812937806122;12499;12515.56195533152;13393.263370514715;11676.357800320724;11713.88286117128;11848.585299514476;12312.569060083213;12384.380780960735;12716.427760750603;12811.295378754257;12913.418896149884;12944.223346598857;13531.661708457368;10295.17638588896;10460.320079194827;11114.44427778624;11181.888181118085;11202.775944481227;9776.315657903879;9966.800663986825;10006.649767258112;10245.436500992517;10256.948715256674 19:19:04 INFO - PROCESS | 3421 | __end_tp_report 19:19:04 INFO - PROCESS | 3421 | __start_cc_report 19:19:04 INFO - PROCESS | 3421 | _x_x_mozilla_cycle_collect,353 19:19:04 INFO - PROCESS | 3421 | __end_cc_report 19:19:04 INFO - PROCESS | 3421 | __startTimestamp1461032344255__endTimestamp 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | ------- Summary: start ------- 19:19:04 INFO - PROCESS | 3421 | Number of tests: 6 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#0] dojo.html Cycles:165 Average:5318.19 Median:5561.56 stddev:712.03 (12.8%) stddev-sans-first:692.97 19:19:04 INFO - PROCESS | 3421 | Values: 3117.8 3138.8 3139.0 3179.9 3190.7 5338.7 5341.8 5345.8 5366.1 5415.2 5305.8 5340.5 5361.9 5428.5 5549.0 4864.2 4904.3 4970.6 4988.4 5038.2 506.0 4817.0 4840.3 4856.2 4895.5 4840.0 4842.7 4855.8 4863.6 4904.4 4858.5 4922.9 4935.3 4945.8 4988.0 4840.3 4874.8 4879.8 4884.7 4921.9 5306.0 5328.1 5349.0 5365.3 5370.4 5595.0 5695.5 5749.4 5797.7 5799.6 5666.7 5722.3 5741.0 5782.7 5791.8 5346.5 5355.2 5356.1 5366.8 5392.0 5684.7 5861.2 5892.8 5894.0 5898.3 5665.3 5723.4 5726.4 5730.4 5775.2 5720.8 5745.2 5745.5 5752.2 5753.9 5564.2 5655.8 5737.3 5740.0 5753.2 5702.7 5734.4 5786.3 5792.7 5805.0 4338.0 4352.5 4363.7 4369.2 4412.7 3868.1 3887.4 3908.8 3918.4 3935.3 5389.9 5400.0 5409.1 5411.4 5457.0 5695.1 5712.4 5755.7 5774.4 5777.2 5356.2 5387.1 5403.2 5419.6 5517.2 4963.9 4970.0 4981.4 4998.8 5019.0 5937.6 5942.2 5995.6 5996.3 6039.4 5719.8 5783.6 5858.1 5866.0 5881.3 5915.3 5947.6 5949.0 5951.3 5958.5 5649.8 5693.6 5695.1 5695.3 5707.6 5525.6 5767.3 5811.2 5834.0 5857.7 5634.6 5647.4 5668.5 5669.0 5679.9 5419.9 5611.4 5673.4 5674.5 5676.2 5394.1 5467.9 5549.4 5564.9 5580.2 5609.0 5633.0 5637.1 5663.1 5723.1 5556.7 5559.2 5561.6 5593.5 5606.3 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#1] ext.html Cycles:180 Average:52298.28 Median:39714.90 stddev:102230.47 (257.4%) stddev-sans-first:102443.59 19:19:04 INFO - PROCESS | 3421 | Values: 607.9 638.3 640.9 651.6 654.4 29582.7 37672.6 38160.8 38241.9 38349.6 39699.2 39811.6 40239.0 40320.0 40353.2 8395.7 8491.8 8637.8 8646.6 8682.6 8497.0 8615.6 8620.0 8638.0 8900.7 8926.6 8997.7 9004.5 9005.1 9031.2 8880.7 8916.8 8942.7 8948.8 8963.1 8756.0 8911.3 8918.3 8919.2 8922.2 39815.8 40012.6 40170.0 40184.6 40255.0 3546.9 3683.9 3809.9 3833.1 4156.5 30631.8 30983.4 31003.2 31013.1 31338.0 4350.7 4358.5 4425.9 4441.7 4537.8 215664.0 215735.0 215950.0 216677.0 216717.0 34748.0 35852.6 35853.5 57182.0 58684.4 34435.3 34573.8 34699.0 34706.3 34720.3 14983.0 15049.5 15154.7 15260.5 15323.2 12361.8 12445.1 12456.2 12485.6 12513.2 8266.7 8301.6 8322.4 8349.7 8399.7 3230.2 3237.0 3280.0 3299.7 3308.0 1070.5 1082.9 1096.3 1187.4 1201.2 31677.7 32054.8 32164.4 32567.5 32766.7 1139.2 1141.3 1152.3 1197.8 1261.6 16550.1 16969.0 16982.3 16997.5 17445.8 463219.0 471920.1 473102.0 473145.0 474202.0 57233.0 57320.0 57609.0 57746.1 57778.7 1367.9 1388.8 1389.5 1401.9 1424.9 31161.0 31771.7 32178.4 32301.7 33298.8 51817.5 51932.0 52127.0 52425.0 52656.7 414522.0 418399.0 420778.0 420892.0 420922.0 28053.9 28122.9 28257.7 28315.0 43390.8 46304.8 46380.5 46530.3 46701.5 46920.3 38281.2 39532.0 39605.2 39731.4 39991.4 39684.8 39730.6 40360.6 40461.6 40733.4 39746.4 41738.4 42603.8 43076.4 43413.3 34709.5 36406.3 36797.4 36812.4 36962.4 26168.0 26910.3 26918.9 27103.5 27523.9 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#2] jquery.html Cycles:180 Average:30198.56 Median:390.50 stddev:93142.17 (23852.1%) stddev-sans-first:93376.56 19:19:04 INFO - PROCESS | 3421 | Values: 388.1 392.9 396.6 400.4 404.9 13838.8 17604.0 18071.5 18346.4 18402.4 16994.3 17076.1 17326.5 18068.9 18133.9 5039.9 5327.1 5338.9 5493.8 5708.9 3681.4 5257.8 5315.6 5364.2 5550.4 5550.4 5552.8 5568.9 5585.9 5604.2 5562.3 5654.6 6149.9 6156.0 6171.0 5407.2 5432.1 5433.1 5434.7 5450.9 11437.8 11872.0 11905.8 12015.8 12051.1 2106.4 2179.7 2184.9 2255.9 2340.0 9247.9 9573.6 9590.8 9663.3 9978.8 1855.6 1902.8 1909.9 1910.0 1925.4 76530.0 80087.2 80578.6 80927.0 81858.6 10394.2 10551.3 10693.6 10719.5 10800.6 12625.7 13079.0 14891.9 14966.0 14968.3 5896.5 6069.8 6835.5 7681.9 7796.2 7228.6 7499.9 7507.0 7551.2 7574.5 4187.9 4318.7 4561.6 4571.1 4676.3 1821.2 1861.0 1889.7 1930.8 1938.5 950.4 1000.4 1075.0 1106.6 1137.1 17194.9 17594.9 17696.9 17721.2 18161.5 1000.2 1045.7 1068.5 1070.6 1096.9 9429.5 10022.4 10123.7 10233.4 10301.7 527627.0 559322.0 574060.1 582631.0 583675.0 93166.0 97815.0 98285.0 98490.0 98699.5 1022.0 1083.0 1092.6 1094.8 1097.4 16259.8 16260.2 16327.0 16333.8 16607.5 37538.0 37718.8 37842.2 39768.0 40507.6 52826.5 54833.7 55024.4 55382.7 55657.0 7119.9 7362.2 7487.2 8003.1 8105.7 8811.3 11322.9 11997.2 12179.5 12522.6 7880.4 11123.2 11420.7 11429.5 11494.5 7173.4 7411.6 7629.2 7636.0 7857.4 7841.4 8036.4 8249.3 8260.4 8515.2 12140.3 12316.3 12503.7 12571.1 12711.4 12079.1 12349.1 12402.3 12470.5 12633.0 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#3] mootools.html Cycles:180 Average:5491.90 Median:4967.78 stddev:3056.92 (61.5%) stddev-sans-first:3050.24 19:19:04 INFO - PROCESS | 3421 | Values: 1428.4 1481.0 1571.7 1725.6 1756.0 7546.4 7920.8 7922.6 8185.3 8203.1 7968.5 7997.8 8020.0 8024.4 8088.3 2294.8 2327.2 2337.4 2337.4 2339.5 2262.0 2267.0 2292.7 2295.4 2299.5 2253.4 2285.1 2300.9 2338.1 2341.7 2140.3 2164.5 2173.1 2177.2 2179.3 2095.2 2108.2 2109.2 2116.2 2124.7 8062.2 8112.5 8196.7 8210.1 8236.2 4990.0 5112.4 5133.5 5138.6 5152.3 3104.5 3120.7 3181.4 3218.1 3221.0 1045.8 1052.0 1052.6 1053.0 1059.1 11274.3 11295.4 11314.7 11325.5 11336.4 4287.8 4310.3 4449.6 4475.6 4494.5 9694.9 9711.0 9738.2 9751.8 9766.9 5127.3 5139.1 5149.8 5153.2 5158.8 4262.1 4669.7 4700.7 4707.5 4747.1 3757.6 3765.1 3803.3 3817.6 3897.6 1196.2 1227.1 1232.9 1240.2 1249.2 915.5 1019.5 1022.1 1027.6 1028.1 5756.1 5849.3 5873.1 5889.4 6060.8 445.8 446.1 448.6 1017.3 1055.1 4096.6 4112.3 4162.4 4210.4 4222.3 9858.3 10262.2 10356.0 10360.7 10474.4 10296.0 10332.3 10352.7 10420.8 10438.2 7715.9 7856.5 7862.6 7879.5 7900.4 5518.6 5796.2 5813.6 5821.9 5924.0 9317.0 9585.2 9588.8 9591.1 9600.5 9319.6 9474.9 9815.8 9908.5 9921.0 6478.7 6732.2 6782.5 6858.8 6960.1 7790.7 7853.2 7874.7 7930.7 7940.4 7054.3 7118.6 7204.1 7267.3 7442.4 7136.3 7183.1 7198.9 7258.8 7336.6 6616.2 6618.4 6630.9 6651.5 6681.1 4920.2 4924.9 4945.6 5302.1 5305.3 5154.1 5175.2 5210.0 5228.6 5272.7 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#4] prototype.html Cycles:180 Average:5258.10 Median:6037.64 stddev:1610.19 (26.7%) stddev-sans-first:1571.05 19:19:04 INFO - PROCESS | 3421 | Values: 296.6 315.5 316.2 316.4 322.7 5851.1 5882.9 5976.4 6051.7 6107.0 5931.2 5996.9 6002.4 6008.9 6023.7 4507.4 4523.5 4533.8 4533.8 4540.8 4433.1 4544.2 4553.3 4600.6 4622.7 4542.3 4543.1 4550.8 4571.5 4587.9 4574.7 4576.6 4586.4 4591.6 4594.4 3658.4 3851.8 3874.2 4000.6 4003.9 5699.0 5730.7 5746.7 5759.2 5777.9 5109.6 5144.0 5170.9 5178.6 5182.7 5942.9 6282.7 6291.0 6316.0 6332.4 4257.4 4286.6 4287.8 4290.4 4296.1 6369.6 6507.4 6509.2 6563.6 6582.7 4344.0 4362.0 4366.5 4368.0 4377.8 4428.4 4435.4 4438.2 4442.8 4447.4 5053.7 5179.8 5191.2 5192.8 5202.5 6132.3 6195.8 6265.9 6361.6 6380.5 1490.3 1508.3 1514.6 1517.0 1528.0 994.4 1001.4 1001.5 1014.7 1020.3 6034.9 6049.2 6054.0 6054.3 6058.4 6495.4 6523.9 6531.8 6552.6 6555.4 5912.6 6040.4 6087.4 6112.3 6112.7 3468.5 3484.7 3491.2 3512.4 3512.9 6515.0 6666.3 6681.4 6691.9 6739.2 6599.5 6613.6 6616.2 6639.1 6722.1 6493.7 6640.0 6648.8 6651.7 6656.5 6476.4 6493.3 6510.6 6514.9 6544.4 6247.8 6428.9 6431.0 6470.5 6481.1 6686.9 6687.3 6692.9 6696.1 6699.9 4311.8 4325.2 4352.3 4366.7 4377.4 6277.0 6346.5 6424.2 6549.4 6601.3 6407.4 6441.0 6452.4 6460.0 6472.6 6216.2 6381.5 6395.4 6423.2 6427.5 6234.2 6245.7 6250.6 6251.3 6282.7 6453.3 6454.9 6461.5 6463.6 6468.5 6019.0 6248.4 6342.2 6343.1 6376.4 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - PROCESS | 3421 | [#5] yui.html Cycles:180 Average:14178.53 Median:45423.43 stddev:16162.44 (35.6%) stddev-sans-first:16176.31 19:19:04 INFO - PROCESS | 3421 | Values: 748.3 770.8 787.5 790.3 797.2 13575.5 13836.6 13985.9 14563.5 14587.9 13398.1 13402.8 13412.7 13444.6 13471.1 675.8 784.4 791.3 806.2 810.8 798.1 802.7 811.5 813.9 815.5 832.6 833.6 836.3 836.7 837.4 823.0 825.5 830.2 831.5 834.4 606.9 608.8 611.2 616.0 617.4 13804.4 13898.3 13903.0 13943.3 13946.2 13551.9 13707.2 13712.7 13733.2 13751.7 10932.3 10943.9 10970.3 10984.9 11262.9 3790.9 3791.6 3845.1 3882.5 3963.6 52218.7 52723.7 52918.2 53050.5 53108.7 10192.4 10338.9 10374.6 10650.4 11507.7 19683.9 19692.0 19713.4 19717.4 19771.0 8059.8 8110.9 8122.6 8358.5 8502.7 4698.8 4722.3 4743.0 4787.8 4856.5 3039.9 3128.3 3140.3 3144.9 3152.7 608.5 611.6 615.8 618.7 622.1 625.8 703.2 705.5 706.6 724.9 8545.7 8597.3 8784.0 8940.0 9223.9 592.5 679.9 709.5 718.4 737.4 4150.3 4275.5 4292.1 4296.4 4395.8 50175.5 51685.7 63828.0 64460.0 64771.0 48635.8 49378.3 50767.7 51529.2 51547.5 46392.3 46513.1 46564.0 46671.3 48239.5 7836.5 7881.9 7891.7 8048.6 8287.8 29021.7 29048.4 29484.9 29658.7 31535.8 43492.0 44112.3 45241.8 45605.1 45630.5 11619.1 11828.8 11880.8 12010.0 12117.9 11854.2 12103.9 12172.6 12570.6 12624.3 12282.4 12470.8 12499.0 12515.6 13393.3 11676.4 11713.9 11848.6 12312.6 12384.4 12716.4 12811.3 12913.4 12944.2 13531.7 10295.2 10460.3 11114.4 11181.9 11202.8 9776.3 9966.8 10006.6 10245.4 10256.9 19:19:04 INFO - PROCESS | 3421 | -------- Summary: end -------- 19:19:04 INFO - PROCESS | 3421 | 19:19:04 INFO - TEST-INFO | 3421: exit 0 19:19:04 INFO - TEST-OK | dromaeo_css | took 1112600ms 19:19:04 INFO - TEST-START | kraken 19:19:04 INFO - operating with platform_type : linux_ 19:19:04 INFO - Initialising browser for kraken test... 19:19:04 INFO - TEST-INFO | started process 3656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1coBZ/profile http://localhost:55289/getInfo.html) 19:19:08 INFO - PROCESS | 3656 | 19:19:08 INFO - PROCESS | 3656 | (process:3725): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:09 INFO - PROCESS | 3656 | __metrics Screen width/height:1600/1200 19:19:09 INFO - PROCESS | 3656 | colorDepth:24 19:19:09 INFO - PROCESS | 3656 | Browser inner width/height: 1024/697 19:19:09 INFO - PROCESS | 3656 | __metrics 19:19:10 ERROR - PROCESS | 3656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:19:11 INFO - TEST-INFO | 3656: exit 0 19:19:11 INFO - Browser initialized. 19:19:11 INFO - Running cycle 1/1 for kraken test... 19:19:11 INFO - TEST-INFO | started process 3776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK1coBZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:13 INFO - PROCESS | 3776 | 19:19:13 INFO - PROCESS | 3776 | (process:3836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:19:23 INFO - PROCESS | 3776 | RSS: Main: 163753984 19:19:23 INFO - PROCESS | 3776 | 19:19:25 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55289/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:26 INFO - PROCESS | 3776 | RSS: Main: 168017920 19:19:26 INFO - PROCESS | 3776 | 19:19:29 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55289/tests/kraken/driver.html?testName=audio-dft) 19:19:30 INFO - PROCESS | 3776 | RSS: Main: 172146688 19:19:30 INFO - PROCESS | 3776 | 19:19:32 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55289/tests/kraken/driver.html?testName=audio-fft) 19:19:33 INFO - PROCESS | 3776 | RSS: Main: 164065280 19:19:33 INFO - PROCESS | 3776 | 19:19:35 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55289/tests/kraken/driver.html?testName=audio-oscillator) 19:19:36 INFO - PROCESS | 3776 | RSS: Main: 163897344 19:19:36 INFO - PROCESS | 3776 | 19:19:38 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55289/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:39 INFO - PROCESS | 3776 | RSS: Main: 164052992 19:19:39 INFO - PROCESS | 3776 | 19:19:42 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55289/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:43 INFO - PROCESS | 3776 | RSS: Main: 164831232 19:19:43 INFO - PROCESS | 3776 | 19:19:46 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55289/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:47 INFO - PROCESS | 3776 | RSS: Main: 164974592 19:19:47 INFO - PROCESS | 3776 | 19:19:49 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55289/tests/kraken/driver.html?testName=json-parse-financial) 19:19:50 INFO - PROCESS | 3776 | RSS: Main: 165658624 19:19:50 INFO - PROCESS | 3776 | 19:19:52 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55289/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:52 INFO - PROCESS | 3776 | RSS: Main: 165404672 19:19:52 INFO - PROCESS | 3776 | 19:19:54 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:55 INFO - PROCESS | 3776 | RSS: Main: 165318656 19:19:55 INFO - PROCESS | 3776 | 19:19:57 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:57 INFO - PROCESS | 3776 | RSS: Main: 165523456 19:19:57 INFO - PROCESS | 3776 | 19:20:01 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:01 INFO - PROCESS | 3776 | RSS: Main: 167460864 19:20:01 INFO - PROCESS | 3776 | 19:20:04 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:04 INFO - PROCESS | 3776 | RSS: Main: 165662720 19:20:04 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | Cycle 1(1): loaded http://localhost:55289/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55289/tests/kraken/driver.html?testName=ai-astar) 19:20:06 INFO - PROCESS | 3776 | RSS: Main: 167256064 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | __start_tp_report 19:20:06 INFO - PROCESS | 3776 | _x_x_mozilla_page_load 19:20:06 INFO - PROCESS | 3776 | _x_x_mozilla_page_load_details 19:20:06 INFO - PROCESS | 3776 | |i|pagename|runs| 19:20:06 INFO - PROCESS | 3776 | |0;ai-astar;111;107;112;111;111;125;112;112;110;113 19:20:06 INFO - PROCESS | 3776 | |1;audio-beat-detection;158;128;161;181;127;151;155;132;179;126 19:20:06 INFO - PROCESS | 3776 | |2;audio-dft;163;161;163;163;162;164;168;161;165;164 19:20:06 INFO - PROCESS | 3776 | |3;audio-fft;77;76;73;159;76;76;72;73;153;79 19:20:06 INFO - PROCESS | 3776 | |4;audio-oscillator;94;92;154;92;93;92;145;92;92;149 19:20:06 INFO - PROCESS | 3776 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;118;118;118 19:20:06 INFO - PROCESS | 3776 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;148;147 19:20:06 INFO - PROCESS | 3776 | |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;96 19:20:06 INFO - PROCESS | 3776 | |8;json-parse-financial;60;60;59;58;60;58;57;73;57;65 19:20:06 INFO - PROCESS | 3776 | |9;json-stringify-tinderbox;62;62;61;63;62;62;61;63;63;61 19:20:06 INFO - PROCESS | 3776 | |10;stanford-crypto-aes;77;76;75;76;78;77;85;77;77;77 19:20:06 INFO - PROCESS | 3776 | |11;stanford-crypto-ccm;126;133;125;125;133;127;127;138;214;133 19:20:06 INFO - PROCESS | 3776 | |12;stanford-crypto-pbkdf2;169;168;167;173;166;174;165;170;169;165 19:20:06 INFO - PROCESS | 3776 | |13;stanford-crypto-sha256-iterative;72;69;70;69;70;73;66;68;67;67 19:20:06 INFO - PROCESS | 3776 | __end_tp_report 19:20:06 INFO - PROCESS | 3776 | __start_cc_report 19:20:06 INFO - PROCESS | 3776 | _x_x_mozilla_cycle_collect,840 19:20:06 INFO - PROCESS | 3776 | __end_cc_report 19:20:06 INFO - PROCESS | 3776 | __startTimestamp1461032406913__endTimestamp 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | ------- Summary: start ------- 19:20:06 INFO - PROCESS | 3776 | Number of tests: 14 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.72 (4.2%) stddev-sans-first:4.98 19:20:06 INFO - PROCESS | 3776 | Values: 111.0 107.0 112.0 111.0 111.0 125.0 112.0 112.0 110.0 113.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.50 stddev:20.88 (13.3%) stddev-sans-first:21.94 19:20:06 INFO - PROCESS | 3776 | Values: 158.0 128.0 161.0 181.0 127.0 151.0 155.0 132.0 179.0 126.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 19:20:06 INFO - PROCESS | 3776 | Values: 163.0 161.0 163.0 163.0 162.0 164.0 168.0 161.0 165.0 164.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#3] audio-fft Cycles:10 Average:91.40 Median:76.00 stddev:34.14 (44.9%) stddev-sans-first:35.81 19:20:06 INFO - PROCESS | 3776 | Values: 77.0 76.0 73.0 159.0 76.0 76.0 72.0 73.0 153.0 79.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.58 (30.0%) stddev-sans-first:28.67 19:20:06 INFO - PROCESS | 3776 | Values: 94.0 92.0 154.0 92.0 93.0 92.0 145.0 92.0 92.0 149.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 19:20:06 INFO - PROCESS | 3776 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 19:20:06 INFO - PROCESS | 3776 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 148.0 147.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:20:06 INFO - PROCESS | 3776 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.00 stddev:4.90 (8.2%) stddev-sans-first:5.19 19:20:06 INFO - PROCESS | 3776 | Values: 60.0 60.0 59.0 58.0 60.0 58.0 57.0 73.0 57.0 65.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:20:06 INFO - PROCESS | 3776 | Values: 62.0 62.0 61.0 63.0 62.0 62.0 61.0 63.0 63.0 61.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.00 stddev:2.76 (3.6%) stddev-sans-first:2.92 19:20:06 INFO - PROCESS | 3776 | Values: 77.0 76.0 75.0 76.0 78.0 77.0 85.0 77.0 77.0 77.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:133.00 stddev:27.03 (20.3%) stddev-sans-first:28.31 19:20:06 INFO - PROCESS | 3776 | Values: 126.0 133.0 125.0 125.0 133.0 127.0 127.0 138.0 214.0 133.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:3.10 (1.8%) stddev-sans-first:3.28 19:20:06 INFO - PROCESS | 3776 | Values: 169.0 168.0 167.0 173.0 166.0 174.0 165.0 170.0 169.0 165.0 19:20:06 INFO - PROCESS | 3776 | 19:20:06 INFO - PROCESS | 3776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:2.23 (3.2%) stddev-sans-first:2.11 19:20:06 INFO - PROCESS | 3776 | Values: 72.0 69.0 70.0 69.0 70.0 73.0 66.0 68.0 67.0 67.0 19:20:06 INFO - PROCESS | 3776 | -------- Summary: end -------- 19:20:06 INFO - PROCESS | 3776 | 19:20:07 INFO - TEST-INFO | 3776: exit 0 19:20:07 INFO - TEST-OK | kraken | took 62992ms 19:20:07 INFO - SUITE-END | took 1175s 19:20:08 INFO - Completed test suite (00:19:35) 19:20:08 INFO - javascript benchmark 19:20:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.8441077946095, 3138.780285380023, 3138.952915706265, 3179.8728050877953, 3190.7447404207664, 5338.665333666583, 5341.839744807652, 5345.7594408251725, 5366.114591092465, 5415.241866138739, 5305.814296499623, 5340.465953404658, 5361.919571206426, 5428.4842939920745, 5549.0289199390145, 4864.221724524077, 4904.337914381566, 4970.552650261476, 4988.401391832967, 5038.2190760432, 506.03713143342367, 4816.988432429194, 4840.298156767267, 4856.150173719585, 4895.485973972735, 4840.0, 4842.709437433748, 4855.8057677693205, 4863.635227357962, 4904.411470623512, 4858.489858564835, 4922.876928076791, 4935.284383764334, 4945.7774400152075, 4987.975060124712, 4840.322354870321, 4874.780634871439, 4879.829205977774, 4884.731339776311, 4921.876953076166, 5306.0, 5328.120860058086, 5349.029945381392, 5365.3293338332705, 5370.382406023318, 5594.9720251398885, 5695.487406133468, 5749.367569567345, 5797.710114494301, 5799.594028418012, 5666.660000399989, 5722.284714410699, 5740.971295143498, 5782.681952492611, 5791.768329266866, 5346.545543628797, 5355.223492593552, 5356.089464790956, 5366.838994830161, 5391.973040134813, 5684.658920464785, 5861.238039054938, 5892.793752218652, 5893.970530147408, 5898.262717160355, 5665.348484924287, 5723.399043100498, 5726.398728133569, 5730.36965933747, 5775.162601422854, 5720.77116915327, 5745.195672605839, 5745.482906538432, 5752.165935939349, 5753.884922301614, 5564.221009058735, 5655.802046928337, 5737.254156959569, 5739.971300143473, 5753.194552762617, 5702.7433765480655, 5734.426557344315, 5786.276715410574, 5792.652440853562, 5805.0, 4337.978310108492, 4352.455943007124, 4363.694541382073, 4369.235383807821, 4412.713173643703, 3868.0716628009077, 3887.4168874669026, 3908.7654740715648, 3918.392649139388, 3935.2916475034194, 5389.946100539023, 5400.027994960945, 5409.053415652245, 5411.404745477994, 5456.990456765511, 5695.117256825199, 5712.400197979152, 5755.740991655385, 5774.393688662714, 5777.19119323295, 5356.223347614574, 5387.111126664056, 5403.2165336026055, 5419.647722897999, 5517.172424136412, 4963.925541116886, 4969.975150124226, 4981.427135879348, 4998.775055122528, 5018.974905125524, 5937.554683398763, 5942.197803296586, 5995.640261584319, 5996.2504686914135, 6039.365866584033, 5719.828405147936, 5783.566232532493, 5858.121281807763, 5865.970670146622, 5881.32364778056, 5915.260592425947, 5947.613405128825, 5949.0, 5951.315598706031, 5958.523318134626, 5649.802256920988, 5693.601447898773, 5695.088785794253, 5695.345035320991, 5707.571932105026, 5525.613207075467, 5767.307923049261, 5811.186433899342, 5834.03738383162, 5857.677827719346, 5634.6337488063145, 5647.435256474319, 5668.51817595509, 5669.036263835241, 5679.886402271849, 5419.945800542102, 5611.410801865745, 5673.404292549388, 5674.4892959633835, 5676.17695434168, 5394.083005889087, 5467.890642187213, 5549.389567147691, 5564.944350556604, 5580.162975553537, 5608.971955140199, 5632.971835140798, 5637.126245431965, 5663.122216056518, 5723.055695810144, 5556.749946252347, 5559.19391688211, 5561.555075594024, 5593.468620481048, 5606.327240731139], "value": 5272.326320153055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.8996965500693, 638.3265654734254, 640.8782331357041, 651.6481100205889, 654.4273760459598, 29582.704172958263, 37672.623273767254, 38160.809195954054, 38241.85274441768, 38349.61650383495, 39699.20601587967, 39811.60188398115, 40239.0, 40320.0, 40353.19293614126, 8395.706150284726, 8491.787705307386, 8637.827243455158, 8646.567671616425, 8682.565871706389, 8497.0, 8615.569221538897, 8619.95690021549, 8637.956810215941, 8900.73297801067, 8926.642934282654, 8997.730068097968, 9004.504752238625, 9005.099490051009, 9031.23234525066, 8880.689175878846, 8916.777080573038, 8942.73171804847, 8948.821023579558, 8963.148500892405, 8755.956220218923, 8911.287097032222, 8918.331125165638, 8919.152680495343, 8922.152395522415, 39815.80092099521, 40012.59987400118, 40169.99575010648, 40184.59815401867, 40255.0, 3546.92042038312, 3683.852645894161, 3809.885703428874, 3833.0936401405966, 4156.501219853637, 30631.81842964851, 30983.380332393226, 31003.22491937697, 31013.0696079118, 31338.0, 4350.673699472521, 4358.4987726411555, 4425.889352766175, 4441.733495990251, 4537.77311134442, 215664.0, 215735.0, 215949.99999999843, 216677.0, 216717.0, 34748.0, 35852.64147358545, 35853.46219806705, 57182.0, 58684.41315586789, 34435.31129377449, 34573.827130864185, 34699.0, 34706.305873882884, 34720.26398680056, 14983.0, 15049.473268435551, 15154.696906061818, 15260.542183734506, 15323.23383830804, 12361.814572781415, 12445.066620003536, 12456.190347627375, 12485.563005294953, 12513.249205047727, 8266.710665126691, 8301.626426810808, 8322.417430779908, 8349.749507514784, 8399.664013439395, 3230.1601583588435, 3237.0, 3279.967200328014, 3299.686529779667, 3307.9834600826844, 1070.4594179939081, 1082.8917108289108, 1096.331237944853, 1187.424099311833, 1201.2012012011915, 31677.683223167933, 32054.83972580169, 32164.35671286561, 32567.51148732771, 32766.672333276838, 1139.1797905508022, 1141.3494308244387, 1152.3086148310947, 1197.7724232395817, 1261.5710658376197, 16550.144289411845, 16969.0, 16982.32070717182, 16997.49007529776, 17445.825541744674, 463219.0, 471920.1231950752, 473102.0, 473145.0, 474202.0, 57233.0, 57320.0, 57609.0, 57746.13380799291, 57778.7111064442, 1367.8837298829512, 1388.8055672205899, 1389.5067251125906, 1401.8948578856628, 1424.9358778854976, 31161.0, 31771.682283176873, 32178.35643287168, 32301.676983229867, 33298.833505832314, 51817.48182518127, 51932.0, 52127.0, 52425.0, 52656.736716316176, 414522.0, 418399.0, 420778.0, 420892.0, 420922.0, 28053.85973070203, 28122.85938570376, 28257.717422826332, 28315.0, 43390.783046084565, 46304.76847615875, 46380.53619463762, 46530.30204547002, 46701.53298466972, 46920.29619555778, 38281.23437531178, 39532.0, 39605.2078958425, 39731.40402894017, 39991.400128997506, 39684.801575991936, 39730.60269397269, 40360.59639403686, 40461.59538404578, 40733.38899916563, 39746.40380394354, 41738.37392439055, 42603.786981066136, 43076.35385469283, 43413.348799767395, 34709.47935780915, 36406.27187456183, 36797.44803827891, 36812.44781328336, 36962.44556331711, 26168.0, 26910.32724181911, 26918.865405672845, 27103.45793084167, 27523.86238068797], "value": 18375.66090848724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.097672910483, 392.89981054831014, 396.6232079524452, 400.39740191012527, 404.8805602347309, 13838.792418113711, 17604.0, 18071.4578562643, 18346.357877474275, 18402.447926562192, 16994.320227190896, 17076.14619269038, 17326.48020559382, 18068.90965545174, 18133.90933045333, 5039.899202015958, 5327.121025030865, 5338.91991620126, 5493.807716729925, 5708.8858222835515, 3681.355762741523, 5257.76340064698, 5315.627906046579, 5364.195370694408, 5550.417206193352, 5550.4449555044575, 5552.805651802188, 5568.916466253009, 5585.888282234373, 5604.215409842625, 5562.276904002474, 5654.6041777075625, 6149.907751383733, 6156.045812899008, 6170.96914515429, 5407.242985981966, 5432.103702889019, 5433.1035379162395, 5434.701091439969, 5450.863728406782, 11437.771244575062, 11872.0, 11905.761884762343, 12015.759684806255, 12051.096167787451, 2106.378618307603, 2179.716636837217, 2184.923527676524, 2255.9210427635117, 2340.021962663462, 9247.907520924771, 9573.569189386495, 9590.76023099421, 9663.26061308964, 9978.750531236705, 1855.5732181598173, 1902.80020597838, 1909.9331523396754, 1909.9522511937173, 1925.4403932814464, 76530.0, 80087.19912800856, 80578.59710701468, 80927.0, 81858.59070704668, 10394.16846652266, 10551.261411701107, 10693.625723099654, 10719.517621707042, 10800.567977280978, 12625.747485050248, 13079.0, 14891.851081489047, 14966.02720823143, 14968.251587420804, 5896.498797602252, 6069.848253793691, 6835.521513494008, 7681.923180768233, 7796.220377962159, 7228.638568071576, 7499.8500029999095, 7506.962465187639, 7551.207123252089, 7574.469787114959, 4187.874363769091, 4318.676099292566, 4561.589456948825, 4571.131485017836, 4676.298555216745, 1821.1713670279992, 1860.9627807443776, 1889.6787546117193, 1930.845532357408, 1938.4959910423393, 950.3680052764972, 1000.4497526360618, 1074.9948797874013, 1106.590561492253, 1137.147139645266, 17194.914025429793, 17594.91202543979, 17696.93818370902, 17721.202545885208, 18161.545961351072, 1000.1648623399398, 1045.6915210013065, 1068.5351871935577, 1070.6359837655234, 1096.9396683182342, 9429.528523573794, 10022.448765317831, 10123.696289111338, 10233.385996840214, 10301.74245643865, 527627.0, 559322.0, 574060.0698440253, 582631.0, 583675.0, 93166.0, 97815.0, 98285.0, 98490.0, 98699.50650246703, 1021.9795604087876, 1082.983755243672, 1092.6230450494568, 1094.8467214589964, 1097.3964319624333, 16259.837401625833, 16260.186990650183, 16327.0, 16333.836661633231, 16607.50177494677, 37538.0, 37718.8114059428, 37842.243155136195, 39768.0, 40507.59492405038, 52826.47173528215, 54833.72583137059, 55024.44975550193, 55382.72308638431, 55657.0, 7119.928800711927, 7362.153352364332, 7487.2138425464545, 8003.07964584057, 8105.716299929474, 8811.33914956368, 11322.886771132513, 11997.220180688228, 12179.512819487121, 12522.561710340095, 7880.448368614142, 11123.165762568002, 11420.657380278604, 11429.542818287508, 11494.482748276514, 7173.390261827803, 7411.629418528944, 7629.198934112061, 7636.0, 7857.4499785014505, 7841.411894108079, 8036.437449378721, 8249.340052795642, 8260.380471464545, 8515.19105684959, 12140.271583705005, 12316.261024338568, 12503.749925001632, 12571.1200215984, 12711.42798574085, 12079.094067945114, 12349.135560510678, 12402.25586464815, 12470.5011799527, 12633.0], "value": 8640.250586683489, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.4286285485805, 1481.03732573827, 1571.7092337917486, 1725.5513566472714, 1755.9552066520416, 7546.4340174487, 7920.801979950504, 7922.643481043352, 8185.3042491388305, 8203.138670439599, 7968.482048666832, 7997.800054998628, 8020.037595488535, 8024.398170137234, 8088.31249343805, 2294.827887908401, 2327.208749025331, 2337.357226762637, 2337.4273303040777, 2339.4853132310864, 2261.9660705089436, 2266.9886650566723, 2292.6790249365104, 2295.426143464134, 2299.540091981602, 2253.4479052632128, 2285.108807565051, 2300.907963681451, 2338.0647740903605, 2341.66045923341, 2140.3364956863265, 2164.5238047629496, 2173.119886445992, 2177.1835561664457, 2179.2917301876873, 2095.19335056003, 2108.1778106538463, 2109.156337465011, 2116.153538584563, 2124.7450305963384, 8062.153473885216, 8112.513249205066, 8196.67213311467, 8210.096889342167, 8236.176382361777, 4989.950100498985, 5112.4120726116225, 5133.512316329943, 5138.58891288696, 5152.330197074356, 3104.518799586068, 3120.719135277836, 3181.3796309719614, 3218.09893229896, 3221.0, 1045.8326667733202, 1051.9579216831316, 1052.5894900988621, 1052.9894701052967, 1059.0534150743597, 11274.267172633752, 11295.378754168518, 11314.660560183125, 11325.490352934137, 11336.433178341133, 4287.785610719451, 4310.267254566731, 4449.555044495589, 4475.619572336323, 4494.505604383515, 9694.854577181348, 9711.0, 9738.220942324597, 9751.804963900824, 9766.9023309766, 5127.256547800548, 5139.100657384943, 5149.76826042829, 5153.2270159476375, 5158.819441319536, 4262.104957958863, 4669.673122881366, 4700.7179569225955, 4707.458642256184, 4747.0505898820375, 3757.5678796938155, 3765.1340191755503, 3803.3154032274456, 3817.6182381762155, 3897.5517815451585, 1196.21050106929, 1227.0796902323257, 1232.9260244385366, 1240.231056744824, 1249.2442072545978, 915.5330781301584, 1019.5106348952396, 1022.1362948308667, 1027.5889644142253, 1028.1466382902174, 5756.0502517084215, 5849.298084229835, 5873.089671100986, 5889.38161493037, 6060.787872424444, 445.7904784751162, 446.1011062708645, 448.5716141085256, 1017.3438132404706, 1055.134789472625, 4096.56986016464, 4112.3420252759415, 4162.41726158338, 4210.368444733314, 4222.303319952173, 9858.260630452745, 10262.230332725076, 10356.0, 10360.740981475523, 10474.371537707762, 10295.970402959643, 10332.328398654063, 10352.741181470523, 10420.843687344695, 10438.164946804238, 7715.92284077152, 7856.489328193764, 7862.646180921873, 7879.487833290817, 7900.4074694397, 5518.641288316247, 5796.21751063601, 5813.593048486566, 5821.94178058214, 5924.0, 9316.95341523288, 9585.233181345615, 9588.760280992752, 9591.088846559565, 9600.519974001132, 9319.580618872302, 9474.905250947402, 9815.803683926139, 9908.504574771378, 9921.0, 6478.676066196577, 6732.158480189976, 6782.457403407814, 6858.759943401957, 6960.129983752031, 7790.727324543614, 7853.214678532101, 7874.72438464651, 7930.682772689028, 7940.404469664682, 7054.329838665319, 7118.572885626879, 7204.063471748639, 7267.273272672691, 7442.404607631484, 7136.250693677089, 7183.066201393785, 7198.8920166198595, 7258.845251758986, 7336.559806411632, 6616.2391324996315, 6618.371254730793, 6630.9336906630315, 6651.501137414616, 6681.1314529110905, 4920.237363208708, 4924.901501970012, 4945.604351651931, 5302.098643230737, 5305.257263983122, 5154.098032844162, 5175.171972484384, 5210.0, 5228.581713462838, 5272.7100009499845], "value": 4407.854186790877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.59662858512417, 315.48260852202384, 316.1795141607528, 316.39410528837266, 322.66926400439553, 5851.122331650244, 5882.911756323659, 5976.402359764027, 6051.667158306292, 6106.961816491196, 5931.199288096106, 5996.850078748033, 6002.369751176118, 6008.939910600892, 6023.728932198051, 4507.414036175309, 4523.547645235475, 4533.773311334437, 4533.8413155539565, 4540.7502587357685, 4433.113377324532, 4544.204764166274, 4553.290791978784, 4600.5629465200755, 4622.676412651116, 4542.295944128666, 4543.114092751898, 4550.817967281305, 4571.47428045774, 4587.908241835161, 4574.656900732425, 4576.588107070363, 4586.403767510219, 4591.586757191869, 4594.379758732562, 3658.396364599838, 3851.788151651658, 3874.1864208516245, 4000.6199411055904, 4003.939940900889, 5698.971505142489, 5730.68481233532, 5746.683932383718, 5759.1937128802, 5777.913331300034, 5109.565686916617, 5144.0, 5170.922436163461, 5178.611604129667, 5182.714950677711, 5942.910856337158, 6282.685865706696, 6290.968545157245, 6315.97888675624, 6332.398422149934, 4257.361395790656, 4286.57134286572, 4287.785610719451, 4290.377895205209, 4296.140771845643, 6369.649669268142, 6507.414332710032, 6509.1863517060365, 6563.638999855006, 6582.670866456706, 4344.0, 4361.956380436155, 4366.519682834885, 4368.0, 4377.824887004548, 4428.357888106207, 4435.35687325336, 4438.201123797748, 4442.778985235743, 4447.421835161408, 5053.729598489271, 5179.8446046618665, 5191.195364718475, 5192.792288308501, 5202.453742357074, 6132.2947860996555, 6195.845103872439, 6265.937340626627, 6361.61830290184, 6380.457661098766, 1490.3368001239562, 1508.2684897824765, 1514.5834895403852, 1516.9772453412986, 1527.9770803437957, 994.3586386780486, 1001.379144930148, 1001.4692213127055, 1014.7158795537262, 1020.3418794877263, 6034.879302414015, 6049.153118563405, 6053.969730151321, 6054.303755068224, 6058.394160583906, 6495.420728386476, 6523.902141467882, 6531.771388001397, 6552.6068435894, 6555.3772391622715, 5912.586118971717, 6040.395960403925, 6087.421694938974, 6112.297085835097, 6112.694365281718, 3468.5317482140094, 3484.651534846546, 3491.1621210909707, 3512.3853325668415, 3512.9121771955392, 6514.967425162844, 6666.300038495888, 6681.398674119256, 6691.895837186809, 6739.191297044386, 6599.505037122235, 6613.636250006296, 6616.206055273398, 6639.136912201479, 6722.092517510074, 6493.740250390026, 6639.966800165968, 6648.800535983928, 6651.66741662915, 6656.5340426169705, 6476.417122459001, 6493.318201588954, 6510.609363438209, 6514.902276465951, 6544.411003009752, 6247.7823920679975, 6428.935710642833, 6430.967845160932, 6470.450011749054, 6481.092647029325, 6686.930091185582, 6687.297833727389, 6692.89567221403, 6696.062551242927, 6699.866002680016, 4311.762853043113, 4325.15659446405, 4352.260115780388, 4366.65066794662, 4377.3871657967275, 6276.968615156895, 6346.4605508532295, 6424.229092508929, 6549.443297319781, 6601.306862779339, 6407.391297826699, 6441.0, 6452.35476452351, 6460.0, 6472.579282346633, 6216.160818289473, 6381.489480841615, 6395.392437718409, 6423.229212494531, 6427.517936154901, 6234.189555357956, 6245.7189426476825, 6250.562460627894, 6251.312355640966, 6282.654454005074, 6453.290138084713, 6454.934935735551, 6461.483081353575, 6463.57986730861, 6468.450181734605, 6019.0, 6248.4376406123665, 6342.175517182736, 6343.143675603735, 6376.353813167483], "value": 4720.328812141552, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.3377211168118, 770.7918861907285, 787.4723934963574, 790.3124281874769, 797.151034148632, 13575.456981720732, 13836.584902452918, 13985.860141398583, 14563.490277840277, 14587.927060364684, 13398.062135650509, 13402.798958015637, 13412.664683382896, 13444.596662100128, 13471.124376915493, 675.797260821754, 784.3725019984018, 791.2878409431514, 806.173671986213, 810.7608255564593, 798.1260519730886, 802.7350974178507, 811.5455345006785, 813.9389545784061, 815.4577206157898, 832.5961908474385, 833.5623797506328, 836.2515548584014, 836.6862426590029, 837.3803385494721, 823.0329362998513, 825.4964471672275, 830.2320353672859, 831.476170012894, 834.3742193354984, 606.8755905039457, 608.8325710429623, 611.1901730207449, 615.9753609855601, 617.3764497857196, 13804.447822087104, 13898.305084745722, 13903.0, 13943.302834858216, 13946.16323020622, 13551.864481355158, 13707.177569345871, 13712.65718357039, 13733.176009439365, 13751.656208594764, 10932.344059356385, 10943.945280273547, 10970.341779493176, 10984.890151098467, 11262.943685281603, 3790.8673196438267, 3791.6018818024263, 3845.057960799594, 3882.4758657581147, 3963.6036396360423, 52218.738906305225, 52723.736381317845, 52918.206226906244, 53050.46949530494, 53108.73445632786, 10192.388456692623, 10338.948305258577, 10374.636887708893, 10650.360978341325, 11507.654770356903, 19683.901580492005, 19692.0, 19713.408597741804, 19717.408477745692, 19771.01144942747, 8059.838803223903, 8110.878336824952, 8122.593870306579, 8358.498490090615, 8502.659893604186, 4698.8120475181295, 4722.268048452495, 4743.02767932573, 4787.784549695272, 4856.514348565115, 3039.878404863781, 3128.2804954860508, 3140.3248301615263, 3144.8742050317733, 3152.6689697581883, 608.4523928464329, 611.6055144431906, 615.7783198048699, 618.6968385491077, 622.0731110645197, 625.7590827531342, 703.2159142556013, 705.5343473307593, 706.5795851468368, 724.905762250904, 8545.74362769118, 8597.269232115215, 8783.956080219557, 8940.0, 9223.907760922439, 592.520058752412, 679.8504329047602, 709.4537206351081, 718.3606590134784, 737.3916518871952, 4150.294449943517, 4275.508316543575, 4292.12011537634, 4296.419983302277, 4395.846145384896, 50175.49824501708, 51685.7415712919, 63828.0, 64460.03309950355, 64771.0, 48635.75682121567, 49378.259326110136, 50767.74616126896, 51529.22706159411, 51547.48452515502, 46392.304115438295, 46513.06973860504, 46564.0, 46671.29993050175, 48239.51760482421, 7836.451448398558, 7881.921180788118, 7891.723789667334, 8048.5793537747395, 8287.792805179919, 29021.7097829019, 29048.419031619673, 29484.852575736983, 29658.703412965595, 31535.84232078917, 43492.0, 44112.33831492466, 45241.773791130836, 45605.08789824119, 45630.54369456263, 11619.128565357802, 11828.763424731285, 11880.821787673365, 12010.039196864054, 12117.939410302892, 11854.229475084092, 12103.878961210276, 12172.634820955385, 12570.622881313575, 12624.305663188612, 12282.385880706108, 12470.812937806122, 12499.0, 12515.56195533152, 13393.263370514715, 11676.357800320724, 11713.88286117128, 11848.585299514476, 12312.569060083213, 12384.380780960735, 12716.427760750603, 12811.295378754257, 12913.418896149884, 12944.223346598857, 13531.661708457368, 10295.17638588896, 10460.320079194827, 11114.44427778624, 11181.888181118085, 11202.775944481227, 9776.315657903879, 9966.800663986825, 10006.649767258112, 10245.436500992517, 10256.948715256674], "value": 6533.576603556062, "unit": "score"}], "name": "dromaeo_css", "value": 6961.350466819096, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 111.0, 111.0, 125.0, 112.0, 112.0, 110.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 161.0, 181.0, 127.0, 151.0, 155.0, 132.0, 179.0, 126.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 162.0, 164.0, 168.0, 161.0, 165.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 73.0, 159.0, 76.0, 76.0, 72.0, 73.0, 153.0, 79.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 154.0, 92.0, 93.0, 92.0, 145.0, 92.0, 92.0, 149.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 148.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 58.0, 60.0, 58.0, 57.0, 73.0, 57.0, 65.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 76.0, 78.0, 77.0, 85.0, 77.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 125.0, 125.0, 133.0, 127.0, 127.0, 138.0, 214.0, 133.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 167.0, 173.0, 166.0, 174.0, 165.0, 170.0, 169.0, 165.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 69.0, 70.0, 73.0, 66.0, 68.0, 67.0, 67.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1561.3999999999996, "alertThreshold": 2.0}]} 19:20:08 INFO - Return code: 0 19:20:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:08 ERROR - # TBPL SUCCESS # 19:20:08 INFO - Running post-action listener: _resource_record_post_action 19:20:08 INFO - Running post-run listener: _resource_record_post_run 19:20:09 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7798784; Write bytes: 440008704; Read time: 2428; Write time: 652100 19:20:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 17920000; Read time: 0; Write time: 25468 19:20:09 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6037504; Write bytes: 422088704; Read time: 2372; Write time: 626632 19:20:09 INFO - Running post-run listener: _upload_blobber_files 19:20:09 INFO - Blob upload gear active. 19:20:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:09 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 19:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:09 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:10 INFO - (blobuploader) - INFO - Done attempting. 19:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:11 INFO - (blobuploader) - INFO - Done attempting. 19:20:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:11 INFO - Return code: 0 19:20:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fad4563b8406bd0f5d2040417e7b01b88e7c4e619045c13826c87fa8d9df3fa813dad27a214bc50126126e15e1b80632efe2cd5c2df3983ed9b4efaee6342339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ef21d9d4ae4282882417c8325d8b878ff8b69d00445b9d9a8446cb28b7aac33c8589f489c1d035de440d754be92c74d578359afbc06415dd55a737c7698572c"} 19:20:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:11 INFO - Contents: 19:20:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fad4563b8406bd0f5d2040417e7b01b88e7c4e619045c13826c87fa8d9df3fa813dad27a214bc50126126e15e1b80632efe2cd5c2df3983ed9b4efaee6342339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ef21d9d4ae4282882417c8325d8b878ff8b69d00445b9d9a8446cb28b7aac33c8589f489c1d035de440d754be92c74d578359afbc06415dd55a737c7698572c"} 19:20:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:11 INFO - Copying logs to upload dir... 19:20:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.577897 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-18 19:20:11.291275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 19:20:11.294633) ========= 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=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fad4563b8406bd0f5d2040417e7b01b88e7c4e619045c13826c87fa8d9df3fa813dad27a214bc50126126e15e1b80632efe2cd5c2df3983ed9b4efaee6342339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ef21d9d4ae4282882417c8325d8b878ff8b69d00445b9d9a8446cb28b7aac33c8589f489c1d035de440d754be92c74d578359afbc06415dd55a737c7698572c"} build_url:https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/SvZ111VOSHi-8TKXNFGGaA/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/Firefox/sha512/fad4563b8406bd0f5d2040417e7b01b88e7c4e619045c13826c87fa8d9df3fa813dad27a214bc50126126e15e1b80632efe2cd5c2df3983ed9b4efaee6342339", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ef21d9d4ae4282882417c8325d8b878ff8b69d00445b9d9a8446cb28b7aac33c8589f489c1d035de440d754be92c74d578359afbc06415dd55a737c7698572c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 19:20:11.324406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 19:20:11.324753) ========= 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=8783db0840cc980e80bb0bd400000236-1461025260.458792-1278480610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 19:20:11.406932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 19:20:11.407696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 19:20:11.408368) ========= ========= Total master_lag: 0.19 =========